builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-035 starttime: 1450790147.4 results: success (0) buildid: 20151222041117 builduid: eeddd808d948466a988a5bfdaddd624b revision: 3cc8559d0d65d5704eedc72238a82c09b4b630cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 05:15:47.402607) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 05:15:47.403080) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 05:15:47.403370) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450790145.943476-374002784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004240 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 05:15:47.420703) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 05:15:47.421004) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 05:15:47.434183) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 05:15:47.434455) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450790145.943476-374002784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004628 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 05:15:47.483128) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 05:15:47.483416) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 05:15:47.483828) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 05:15:47.484118) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450790145.943476-374002784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-22 05:15:47-- 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% 61.2M=0s 2015-12-22 05:15:47 (61.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.239790 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 05:15:47.736395) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 05:15:47.736729) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450790145.943476-374002784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.081280 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 05:15:47.830680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 05:15:47.831103) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3cc8559d0d65d5704eedc72238a82c09b4b630cd --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 3cc8559d0d65d5704eedc72238a82c09b4b630cd --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=0d7d1540fd7fba0c6b8b7f12000001dc-1450790145.943476-374002784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-22 05:15:47,666 truncating revision to first 12 chars 2015-12-22 05:15:47,666 Setting DEBUG logging. 2015-12-22 05:15:47,666 attempt 1/10 2015-12-22 05:15:47,666 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3cc8559d0d65?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-22 05:15:47,927 unpacking tar archive at: fx-team-3cc8559d0d65/testing/mozharness/ program finished with exit code 0 elapsedTime=0.544636 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 05:15:48.389220) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 05:15:48.389543) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 05:15:48.398421) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 05:15:48.398780) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 05:15:48.399247) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-22 05:15:48.399536) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --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', '--system-bits', '64', '--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=0d7d1540fd7fba0c6b8b7f12000001dc-1450790145.943476-374002784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:15:48 INFO - MultiFileLogger online at 20151222 05:15:48 in /builds/slave/test 05:15:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:15:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:15:48 INFO - {'append_to_log': False, 05:15:48 INFO - 'base_work_dir': '/builds/slave/test', 05:15:48 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:15:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:15:48 INFO - 'branch': 'Fx-Team-Non-PGO', 05:15:48 INFO - 'buildbot_json_path': 'buildprops.json', 05:15:48 INFO - 'config_files': ('talos/linux_config.py',), 05:15:48 INFO - 'default_actions': ('clobber', 05:15:48 INFO - 'read-buildbot-config', 05:15:48 INFO - 'download-and-extract', 05:15:48 INFO - 'populate-webroot', 05:15:48 INFO - 'create-virtualenv', 05:15:48 INFO - 'install', 05:15:48 INFO - 'run-tests'), 05:15:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:15:48 INFO - 'download_minidump_stackwalk': True, 05:15:48 INFO - 'download_symbols': 'ondemand', 05:15:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:15:48 INFO - 'tooltool.py': '/tools/tooltool.py', 05:15:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:15:48 INFO - '/tools/misc-python/virtualenv.py')}, 05:15:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:15:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:15:48 INFO - 'installer_path': 'installer.exe', 05:15:48 INFO - 'log_level': 'info', 05:15:48 INFO - 'log_name': 'talos', 05:15:48 INFO - 'log_to_console': True, 05:15:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:15:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:15:48 INFO - 'opt_config_files': (), 05:15:48 INFO - 'pip_index': False, 05:15:48 INFO - 'sps_profile': False, 05:15:48 INFO - 'sps_profile_interval': 0, 05:15:48 INFO - 'suite': 'dromaeojs', 05:15:48 INFO - 'system_bits': '64', 05:15:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:15:48 INFO - 'title': 'talos-linux64-ix-035', 05:15:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:15:48 INFO - 'use_talos_json': True, 05:15:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:15:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:15:48 INFO - 'work_dir': 'build'} 05:15:48 INFO - ##### 05:15:48 INFO - ##### Running clobber step. 05:15:48 INFO - ##### 05:15:48 INFO - Running pre-action listener: _resource_record_pre_action 05:15:48 INFO - Running main action method: clobber 05:15:48 INFO - rmtree: /builds/slave/test/build 05:15:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:15:49 INFO - Running post-action listener: _resource_record_post_action 05:15:49 INFO - ##### 05:15:49 INFO - ##### Running read-buildbot-config step. 05:15:49 INFO - ##### 05:15:49 INFO - Running pre-action listener: _resource_record_pre_action 05:15:49 INFO - Running main action method: read_buildbot_config 05:15:49 INFO - Using buildbot properties: 05:15:49 INFO - { 05:15:49 INFO - "project": "", 05:15:49 INFO - "product": "firefox", 05:15:49 INFO - "script_repo_revision": "production", 05:15:49 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:15:49 INFO - "repository": "", 05:15:49 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:15:49 INFO - "buildid": "20151222041117", 05:15:49 INFO - "pgo_build": "False", 05:15:49 INFO - "basedir": "/builds/slave/test", 05:15:49 INFO - "buildnumber": 2241, 05:15:49 INFO - "slavename": "talos-linux64-ix-035", 05:15:49 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:15:49 INFO - "platform": "ubuntu64_hw", 05:15:49 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:15:49 INFO - "branch": "fx-team", 05:15:49 INFO - "repo_path": "integration/fx-team", 05:15:49 INFO - "revision": "3cc8559d0d65d5704eedc72238a82c09b4b630cd", 05:15:49 INFO - "stage_platform": "linux64", 05:15:49 INFO - "builduid": "eeddd808d948466a988a5bfdaddd624b", 05:15:49 INFO - "slavebuilddir": "test" 05:15:49 INFO - } 05:15:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/aWnEqmWcTTSAZB8hl6GKTw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:15:49 INFO - Running post-action listener: _resource_record_post_action 05:15:49 INFO - ##### 05:15:49 INFO - ##### Running download-and-extract step. 05:15:49 INFO - ##### 05:15:49 INFO - Running pre-action listener: _resource_record_pre_action 05:15:49 INFO - Running main action method: download_and_extract 05:15:49 INFO - mkdir: /builds/slave/test/build/tests 05:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:49 INFO - https://queue.taskcluster.net/v1/task/aWnEqmWcTTSAZB8hl6GKTw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:15:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWnEqmWcTTSAZB8hl6GKTw/artifacts/public/build/test_packages.json 05:15:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWnEqmWcTTSAZB8hl6GKTw/artifacts/public/build/test_packages.json 05:15:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWnEqmWcTTSAZB8hl6GKTw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:15:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWnEqmWcTTSAZB8hl6GKTw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:15:50 INFO - Downloaded 1302 bytes. 05:15:50 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:15:50 INFO - Using the following test package requirements: 05:15:50 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:15:50 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:15:50 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:50 INFO - u'jsshell-linux-x86_64.zip'], 05:15:50 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:15:50 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:15:50 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:15:50 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:15:50 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:15:50 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:15:50 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:15:50 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:15: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')]} 05:15:50 INFO - https://queue.taskcluster.net/v1/task/aWnEqmWcTTSAZB8hl6GKTw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:15:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWnEqmWcTTSAZB8hl6GKTw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:15:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWnEqmWcTTSAZB8hl6GKTw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:15:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWnEqmWcTTSAZB8hl6GKTw/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 05:15:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWnEqmWcTTSAZB8hl6GKTw/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 05:15:52 INFO - Downloaded 21926924 bytes. 05:15:52 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 05:15:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:15:52 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 05:15:53 INFO - Return code: 0 05:15:53 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 05:15: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')]} 05:15:53 INFO - https://queue.taskcluster.net/v1/task/aWnEqmWcTTSAZB8hl6GKTw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:15:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWnEqmWcTTSAZB8hl6GKTw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:15:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWnEqmWcTTSAZB8hl6GKTw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:15:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWnEqmWcTTSAZB8hl6GKTw/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 05:15:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWnEqmWcTTSAZB8hl6GKTw/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 05:15:54 INFO - Downloaded 21926924 bytes. 05:15:54 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 05:15:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:15:54 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 05:15:56 INFO - Return code: 0 05:15: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')]} 05:15:56 INFO - https://queue.taskcluster.net/v1/task/aWnEqmWcTTSAZB8hl6GKTw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:15:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWnEqmWcTTSAZB8hl6GKTw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:15:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWnEqmWcTTSAZB8hl6GKTw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:15:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWnEqmWcTTSAZB8hl6GKTw/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 05:15:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWnEqmWcTTSAZB8hl6GKTw/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 05:15:57 INFO - Downloaded 11132277 bytes. 05:15:57 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 05:15:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:15:57 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 05:15:57 INFO - Return code: 0 05:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:57 INFO - https://queue.taskcluster.net/v1/task/aWnEqmWcTTSAZB8hl6GKTw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:15:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWnEqmWcTTSAZB8hl6GKTw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:15:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWnEqmWcTTSAZB8hl6GKTw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:15:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWnEqmWcTTSAZB8hl6GKTw/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 05:15:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWnEqmWcTTSAZB8hl6GKTw/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 05:15:59 INFO - Downloaded 53348559 bytes. 05:15:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aWnEqmWcTTSAZB8hl6GKTw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:15:59 INFO - mkdir: /builds/slave/test/properties 05:15:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:15:59 INFO - Writing to file /builds/slave/test/properties/build_url 05:15:59 INFO - Contents: 05:15:59 INFO - build_url:https://queue.taskcluster.net/v1/task/aWnEqmWcTTSAZB8hl6GKTw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:15:59 INFO - Running post-action listener: _resource_record_post_action 05:15:59 INFO - Running post-action listener: set_extra_try_arguments 05:15:59 INFO - ##### 05:15:59 INFO - ##### Running populate-webroot step. 05:15:59 INFO - ##### 05:15:59 INFO - Running pre-action listener: _resource_record_pre_action 05:15:59 INFO - Running main action method: populate_webroot 05:15:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:15:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:15:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:15:59 INFO - '--tppagecycles', 05:15:59 INFO - '7'], 05:15:59 INFO - 'tests': ['tsvgm']}}, 05:15:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:15:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:15:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:15:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:15:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:15:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:15:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:15:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:59 INFO - 'talos_options': ['--e10s'], 05:15:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:15:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:59 INFO - 'tests': ['damp', 'tps']}, 05:15:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:59 INFO - 'talos_options': ['--e10s'], 05:15:59 INFO - 'tests': ['damp', 'tps']}, 05:15:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:15:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:15:59 INFO - 'other': {'tests': ['a11yr', 05:15:59 INFO - 'ts_paint', 05:15:59 INFO - 'tpaint', 05:15:59 INFO - 'sessionrestore', 05:15:59 INFO - 'sessionrestore_no_auto_restore']}, 05:15:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:15:59 INFO - 'tests': ['a11yr', 05:15:59 INFO - 'ts_paint', 05:15:59 INFO - 'tpaint', 05:15:59 INFO - 'sessionrestore', 05:15:59 INFO - 'sessionrestore_no_auto_restore']}, 05:15:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:15:59 INFO - 'tests': ['a11yr', 05:15:59 INFO - 'ts_paint', 05:15:59 INFO - 'tpaint', 05:15:59 INFO - 'sessionrestore', 05:15:59 INFO - 'sessionrestore_no_auto_restore']}, 05:15:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:15:59 INFO - 'tests': ['a11yr', 05:15:59 INFO - 'ts_paint', 05:15:59 INFO - 'tpaint', 05:15:59 INFO - 'sessionrestore', 05:15:59 INFO - 'sessionrestore_no_auto_restore']}, 05:15:59 INFO - 'other_l64': {'tests': ['a11yr', 05:15:59 INFO - 'ts_paint', 05:15:59 INFO - 'tpaint', 05:15:59 INFO - 'sessionrestore', 05:15:59 INFO - 'sessionrestore_no_auto_restore']}, 05:15:59 INFO - 'other_nol64': {'tests': ['a11yr', 05:15:59 INFO - 'ts_paint', 05:15:59 INFO - 'tpaint', 05:15:59 INFO - 'sessionrestore', 05:15:59 INFO - 'sessionrestore_no_auto_restore']}, 05:15:59 INFO - 'svgr': {'tests': ['tsvgx', 05:15:59 INFO - 'tsvgr_opacity', 05:15:59 INFO - 'tart', 05:15:59 INFO - 'tscrollx', 05:15:59 INFO - 'cart']}, 05:15:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:15:59 INFO - 'tests': ['tsvgx', 05:15:59 INFO - 'tsvgr_opacity', 05:15:59 INFO - 'tart', 05:15:59 INFO - 'tscrollx', 05:15:59 INFO - 'cart']}, 05:15:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:59 INFO - 'tests': ['tp5o']}, 05:15:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:59 INFO - 'talos_options': ['--e10s'], 05:15:59 INFO - 'tests': ['tp5o']}, 05:15:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:59 INFO - 'talos_options': ['--xperf_path', 05:15:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:15:59 INFO - 'tests': ['tp5n']}, 05:15:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:59 INFO - 'talos_options': ['--e10s', 05:15:59 INFO - '--xperf_path', 05:15:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:15:59 INFO - 'tests': ['tp5n']}}, 05:15:59 INFO - 'talos.zip': {'path': '', 05:15:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:15:59 INFO - Running post-action listener: _resource_record_post_action 05:15:59 INFO - ##### 05:15:59 INFO - ##### Running create-virtualenv step. 05:15:59 INFO - ##### 05:15:59 INFO - Running pre-action listener: _resource_record_pre_action 05:15:59 INFO - Running main action method: create_virtualenv 05:15:59 INFO - Creating virtualenv /builds/slave/test/build/venv 05:15:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:15:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:15:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:15:59 INFO - Using real prefix '/usr' 05:15:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:15:59 INFO - Installing distribute.............................................................................................................................................................................................done. 05:16:01 INFO - Installing pip.................done. 05:16:01 INFO - Return code: 0 05:16:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:01 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 0x7faf8656df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23aadd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243d3d0>, '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 0x23a8ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a9360>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450790145.943476-374002784', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:16:01 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 05:16:01 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 05:16:01 INFO - Using env: {'DISPLAY': ':0', 05:16:01 INFO - 'HOME': '/home/cltbld', 05:16:01 INFO - 'LANG': 'en_US.UTF-8', 05:16:01 INFO - 'LANGUAGE': 'en_US:en', 05:16:01 INFO - 'LOGNAME': 'cltbld', 05:16:01 INFO - 'MAIL': '/var/mail/cltbld', 05:16:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:01 INFO - 'MOZ_NO_REMOTE': '1', 05:16:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:01 INFO - 'NO_EM_RESTART': '1', 05:16:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:01 INFO - 'PWD': '/builds/slave/test', 05:16:01 INFO - 'SHELL': '/bin/bash', 05:16:01 INFO - 'SHLVL': '1', 05:16:01 INFO - 'TERM': 'linux', 05:16:01 INFO - 'TMOUT': '86400', 05:16:01 INFO - 'USER': 'cltbld', 05:16:01 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450790145.943476-374002784', 05:16:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:01 INFO - '_': '/tools/buildbot/bin/python'} 05:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:16:02 INFO - Cleaning up... 05:16:02 INFO - Return code: 0 05:16:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:16: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')]} 05:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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')]} 05:16:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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', '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 0x7faf8656df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23aadd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243d3d0>, '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 0x23a8ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a9360>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450790145.943476-374002784', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:16: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', 'psutil>=0.7.1'] in /builds/slave/test/build 05:16: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 psutil>=0.7.1 05:16:02 INFO - Using env: {'DISPLAY': ':0', 05:16:02 INFO - 'HOME': '/home/cltbld', 05:16:02 INFO - 'LANG': 'en_US.UTF-8', 05:16:02 INFO - 'LANGUAGE': 'en_US:en', 05:16:02 INFO - 'LOGNAME': 'cltbld', 05:16:02 INFO - 'MAIL': '/var/mail/cltbld', 05:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:02 INFO - 'MOZ_NO_REMOTE': '1', 05:16:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:02 INFO - 'NO_EM_RESTART': '1', 05:16:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:02 INFO - 'PWD': '/builds/slave/test', 05:16:02 INFO - 'SHELL': '/bin/bash', 05:16:02 INFO - 'SHLVL': '1', 05:16:02 INFO - 'TERM': 'linux', 05:16:02 INFO - 'TMOUT': '86400', 05:16:02 INFO - 'USER': 'cltbld', 05:16:02 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450790145.943476-374002784', 05:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:02 INFO - '_': '/tools/buildbot/bin/python'} 05:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:03 INFO - Downloading/unpacking psutil>=0.7.1 05:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:05 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:16:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:16:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:16:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:05 INFO - Installing collected packages: psutil 05:16:05 INFO - Running setup.py install for psutil 05:16:05 INFO - building 'psutil._psutil_linux' extension 05:16:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:16:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:16:10 INFO - building 'psutil._psutil_posix' extension 05:16:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:16:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:16:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:10 INFO - Successfully installed psutil 05:16:10 INFO - Cleaning up... 05:16:10 INFO - Return code: 0 05:16:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:10 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 0x7faf8656df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23aadd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243d3d0>, '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 0x23a8ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a9360>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450790145.943476-374002784', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:16:10 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 05:16:10 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 05:16:10 INFO - Using env: {'DISPLAY': ':0', 05:16:10 INFO - 'HOME': '/home/cltbld', 05:16:10 INFO - 'LANG': 'en_US.UTF-8', 05:16:10 INFO - 'LANGUAGE': 'en_US:en', 05:16:10 INFO - 'LOGNAME': 'cltbld', 05:16:10 INFO - 'MAIL': '/var/mail/cltbld', 05:16:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:10 INFO - 'MOZ_NO_REMOTE': '1', 05:16:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:10 INFO - 'NO_EM_RESTART': '1', 05:16:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:10 INFO - 'PWD': '/builds/slave/test', 05:16:10 INFO - 'SHELL': '/bin/bash', 05:16:10 INFO - 'SHLVL': '1', 05:16:10 INFO - 'TERM': 'linux', 05:16:10 INFO - 'TMOUT': '86400', 05:16:10 INFO - 'USER': 'cltbld', 05:16:10 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450790145.943476-374002784', 05:16:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:10 INFO - '_': '/tools/buildbot/bin/python'} 05:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:16:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:16:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:16:12 INFO - Installing collected packages: mozsystemmonitor 05:16:12 INFO - Running setup.py install for mozsystemmonitor 05:16:12 INFO - Successfully installed mozsystemmonitor 05:16:12 INFO - Cleaning up... 05:16:12 INFO - Return code: 0 05:16:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:12 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 0x7faf8656df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23aadd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243d3d0>, '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 0x23a8ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a9360>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450790145.943476-374002784', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:16:12 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 05:16:12 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 05:16:12 INFO - Using env: {'DISPLAY': ':0', 05:16:12 INFO - 'HOME': '/home/cltbld', 05:16:12 INFO - 'LANG': 'en_US.UTF-8', 05:16:12 INFO - 'LANGUAGE': 'en_US:en', 05:16:12 INFO - 'LOGNAME': 'cltbld', 05:16:12 INFO - 'MAIL': '/var/mail/cltbld', 05:16:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:12 INFO - 'MOZ_NO_REMOTE': '1', 05:16:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:12 INFO - 'NO_EM_RESTART': '1', 05:16:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:12 INFO - 'PWD': '/builds/slave/test', 05:16:12 INFO - 'SHELL': '/bin/bash', 05:16:12 INFO - 'SHLVL': '1', 05:16:12 INFO - 'TERM': 'linux', 05:16:12 INFO - 'TMOUT': '86400', 05:16:12 INFO - 'USER': 'cltbld', 05:16:12 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450790145.943476-374002784', 05:16:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:12 INFO - '_': '/tools/buildbot/bin/python'} 05:16:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:13 INFO - Downloading/unpacking blobuploader==1.2.4 05:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:14 INFO - Downloading blobuploader-1.2.4.tar.gz 05:16:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:16:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:16:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:16:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:16:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:15 INFO - Downloading docopt-0.6.1.tar.gz 05:16:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:16:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:16:15 INFO - Installing collected packages: blobuploader, requests, docopt 05:16:15 INFO - Running setup.py install for blobuploader 05:16:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:16:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:16:15 INFO - Running setup.py install for requests 05:16:15 INFO - Running setup.py install for docopt 05:16:16 INFO - Successfully installed blobuploader requests docopt 05:16:16 INFO - Cleaning up... 05:16:16 INFO - Return code: 0 05:16:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:16 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 0x7faf8656df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23aadd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243d3d0>, '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 0x23a8ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a9360>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450790145.943476-374002784', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:16:16 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 05:16:16 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 05:16:16 INFO - Using env: {'DISPLAY': ':0', 05:16:16 INFO - 'HOME': '/home/cltbld', 05:16:16 INFO - 'LANG': 'en_US.UTF-8', 05:16:16 INFO - 'LANGUAGE': 'en_US:en', 05:16:16 INFO - 'LOGNAME': 'cltbld', 05:16:16 INFO - 'MAIL': '/var/mail/cltbld', 05:16:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:16 INFO - 'MOZ_NO_REMOTE': '1', 05:16:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:16 INFO - 'NO_EM_RESTART': '1', 05:16:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:16 INFO - 'PWD': '/builds/slave/test', 05:16:16 INFO - 'SHELL': '/bin/bash', 05:16:16 INFO - 'SHLVL': '1', 05:16:16 INFO - 'TERM': 'linux', 05:16:16 INFO - 'TMOUT': '86400', 05:16:16 INFO - 'USER': 'cltbld', 05:16:16 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450790145.943476-374002784', 05:16:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:16 INFO - '_': '/tools/buildbot/bin/python'} 05:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:16 INFO - Running setup.py (path:/tmp/pip-iHZS6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:16 INFO - Running setup.py (path:/tmp/pip-TjRX8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:16 INFO - Running setup.py (path:/tmp/pip-yaBSPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:16 INFO - Running setup.py (path:/tmp/pip-vFyHZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:16 INFO - Running setup.py (path:/tmp/pip-O_VZqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:16 INFO - Running setup.py (path:/tmp/pip-ZwbwOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:16 INFO - Running setup.py (path:/tmp/pip-qL8XB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:16 INFO - Running setup.py (path:/tmp/pip-xzYaY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:16 INFO - Running setup.py (path:/tmp/pip-kLZY7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:16 INFO - Running setup.py (path:/tmp/pip-hfDsFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:17 INFO - Running setup.py (path:/tmp/pip-UPdZFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:17 INFO - Running setup.py (path:/tmp/pip-HHc6_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:17 INFO - Running setup.py (path:/tmp/pip-mItRSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:17 INFO - Running setup.py (path:/tmp/pip-ArQ_A2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:17 INFO - Running setup.py (path:/tmp/pip-D6Vfy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:17 INFO - Running setup.py (path:/tmp/pip-uyNuwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:17 INFO - Running setup.py (path:/tmp/pip-0DMyL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:16:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:16:17 INFO - Running setup.py install for manifestparser 05:16:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:16:17 INFO - Running setup.py install for mozcrash 05:16:17 INFO - Running setup.py install for mozdebug 05:16:17 INFO - Running setup.py install for mozdevice 05:16:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:16:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:16:17 INFO - Running setup.py install for mozfile 05:16:18 INFO - Running setup.py install for mozhttpd 05:16:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:16:18 INFO - Running setup.py install for mozinfo 05:16:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:16:18 INFO - Running setup.py install for mozInstall 05:16:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:16:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:16:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:16:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:16:18 INFO - Running setup.py install for mozleak 05:16:18 INFO - Running setup.py install for mozlog 05:16:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:16:18 INFO - Running setup.py install for moznetwork 05:16:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:16:18 INFO - Running setup.py install for mozprocess 05:16:18 INFO - Running setup.py install for mozprofile 05:16:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:16:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:16:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:16:18 INFO - Running setup.py install for mozrunner 05:16:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:16:19 INFO - Running setup.py install for mozscreenshot 05:16:19 INFO - Running setup.py install for moztest 05:16:19 INFO - Running setup.py install for mozversion 05:16:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:16:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:16:19 INFO - Cleaning up... 05:16:19 INFO - Return code: 0 05:16:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:19 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 0x7faf8656df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23aadd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243d3d0>, '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 0x23a8ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a9360>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450790145.943476-374002784', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:16:19 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 05:16:19 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 05:16:19 INFO - Using env: {'DISPLAY': ':0', 05:16:19 INFO - 'HOME': '/home/cltbld', 05:16:19 INFO - 'LANG': 'en_US.UTF-8', 05:16:19 INFO - 'LANGUAGE': 'en_US:en', 05:16:19 INFO - 'LOGNAME': 'cltbld', 05:16:19 INFO - 'MAIL': '/var/mail/cltbld', 05:16:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:19 INFO - 'MOZ_NO_REMOTE': '1', 05:16:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:19 INFO - 'NO_EM_RESTART': '1', 05:16:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:19 INFO - 'PWD': '/builds/slave/test', 05:16:19 INFO - 'SHELL': '/bin/bash', 05:16:19 INFO - 'SHLVL': '1', 05:16:19 INFO - 'TERM': 'linux', 05:16:19 INFO - 'TMOUT': '86400', 05:16:19 INFO - 'USER': 'cltbld', 05:16:19 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450790145.943476-374002784', 05:16:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:19 INFO - '_': '/tools/buildbot/bin/python'} 05:16:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:19 INFO - Running setup.py (path:/tmp/pip-JFWg6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:19 INFO - Running setup.py (path:/tmp/pip-9q9D5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:19 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)) 05:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:19 INFO - Running setup.py (path:/tmp/pip-XWLwgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:19 INFO - Running setup.py (path:/tmp/pip-lx2Zjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:19 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)) 05:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:19 INFO - Running setup.py (path:/tmp/pip-yW6FW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:19 INFO - Running setup.py (path:/tmp/pip-43kKEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:20 INFO - Running setup.py (path:/tmp/pip-Jx1KNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:20 INFO - Running setup.py (path:/tmp/pip-_h2PmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:20 INFO - Running setup.py (path:/tmp/pip-hFFNzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:20 INFO - Running setup.py (path:/tmp/pip-nnY_Gg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:20 INFO - Running setup.py (path:/tmp/pip-2zZHbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:20 INFO - Running setup.py (path:/tmp/pip-SolD8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:20 INFO - Running setup.py (path:/tmp/pip-X6abKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:20 INFO - Running setup.py (path:/tmp/pip-ZxJwdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:20 INFO - Running setup.py (path:/tmp/pip-xE4xwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:20 INFO - Running setup.py (path:/tmp/pip-I_bf0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:20 INFO - Running setup.py (path:/tmp/pip-z11pac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:16:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:16:20 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)) 05:16:20 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)) 05:16:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:16:20 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)) 05:16:20 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)) 05:16:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:22 INFO - Downloading blessings-1.5.1.tar.gz 05:16:22 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 05:16:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:16:22 INFO - Installing collected packages: blessings 05:16:22 INFO - Running setup.py install for blessings 05:16:22 INFO - Successfully installed blessings 05:16:22 INFO - Cleaning up... 05:16:22 INFO - Return code: 0 05:16:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:16:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:16:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:16:22 INFO - Reading from file tmpfile_stdout 05:16:22 INFO - Current package versions: 05:16:22 INFO - argparse == 1.2.1 05:16:22 INFO - blessings == 1.5.1 05:16:22 INFO - blobuploader == 1.2.4 05:16:22 INFO - docopt == 0.6.1 05:16:22 INFO - manifestparser == 1.1 05:16:22 INFO - mozInstall == 1.12 05:16:22 INFO - mozcrash == 0.16 05:16:22 INFO - mozdebug == 0.1 05:16:22 INFO - mozdevice == 0.47 05:16:22 INFO - mozfile == 1.2 05:16:22 INFO - mozhttpd == 0.7 05:16:22 INFO - mozinfo == 0.9 05:16:22 INFO - mozleak == 0.1 05:16:22 INFO - mozlog == 3.1 05:16:22 INFO - moznetwork == 0.27 05:16:22 INFO - mozprocess == 0.22 05:16:22 INFO - mozprofile == 0.28 05:16:22 INFO - mozrunner == 6.11 05:16:22 INFO - mozscreenshot == 0.1 05:16:22 INFO - mozsystemmonitor == 0.0 05:16:22 INFO - moztest == 0.7 05:16:22 INFO - mozversion == 1.4 05:16:22 INFO - psutil == 3.1.1 05:16:22 INFO - requests == 1.2.3 05:16:22 INFO - wsgiref == 0.1.2 05:16:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:22 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 0x7faf8656df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23aadd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243d3d0>, '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 0x23a8ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a9360>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450790145.943476-374002784', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:16:22 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 05:16:22 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 05:16:22 INFO - Using env: {'DISPLAY': ':0', 05:16:22 INFO - 'HOME': '/home/cltbld', 05:16:22 INFO - 'LANG': 'en_US.UTF-8', 05:16:22 INFO - 'LANGUAGE': 'en_US:en', 05:16:22 INFO - 'LOGNAME': 'cltbld', 05:16:22 INFO - 'MAIL': '/var/mail/cltbld', 05:16:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:22 INFO - 'MOZ_NO_REMOTE': '1', 05:16:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:22 INFO - 'NO_EM_RESTART': '1', 05:16:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:22 INFO - 'PWD': '/builds/slave/test', 05:16:22 INFO - 'SHELL': '/bin/bash', 05:16:22 INFO - 'SHLVL': '1', 05:16:22 INFO - 'TERM': 'linux', 05:16:22 INFO - 'TMOUT': '86400', 05:16:22 INFO - 'USER': 'cltbld', 05:16:22 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450790145.943476-374002784', 05:16:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:22 INFO - '_': '/tools/buildbot/bin/python'} 05:16:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:16:23 INFO - Cleaning up... 05:16:23 INFO - Return code: 0 05:16:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:23 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 0x7faf8656df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23aadd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243d3d0>, '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 0x23a8ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a9360>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450790145.943476-374002784', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:16:23 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 05:16:23 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 05:16:23 INFO - Using env: {'DISPLAY': ':0', 05:16:23 INFO - 'HOME': '/home/cltbld', 05:16:23 INFO - 'LANG': 'en_US.UTF-8', 05:16:23 INFO - 'LANGUAGE': 'en_US:en', 05:16:23 INFO - 'LOGNAME': 'cltbld', 05:16:23 INFO - 'MAIL': '/var/mail/cltbld', 05:16:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:23 INFO - 'MOZ_NO_REMOTE': '1', 05:16:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:23 INFO - 'NO_EM_RESTART': '1', 05:16:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:23 INFO - 'PWD': '/builds/slave/test', 05:16:23 INFO - 'SHELL': '/bin/bash', 05:16:23 INFO - 'SHLVL': '1', 05:16:23 INFO - 'TERM': 'linux', 05:16:23 INFO - 'TMOUT': '86400', 05:16:23 INFO - 'USER': 'cltbld', 05:16:23 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450790145.943476-374002784', 05:16:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:23 INFO - '_': '/tools/buildbot/bin/python'} 05:16:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:23 INFO - Downloading/unpacking jsonschema 05:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:16:25 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 05:16:25 INFO - Downloading/unpacking functools32 (from jsonschema) 05:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:25 INFO - Downloading functools32-3.2.3-2.tar.gz 05:16:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:16:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:16:25 INFO - warning: no files found matching '*.txt' 05:16:25 INFO - no previously-included directories found matching 'build' 05:16:25 INFO - no previously-included directories found matching 'dist' 05:16:25 INFO - no previously-included directories found matching '.git*' 05:16:25 INFO - Installing collected packages: jsonschema, functools32 05:16:25 INFO - Running setup.py install for functools32 05:16:25 INFO - warning: no files found matching '*.txt' 05:16:25 INFO - no previously-included directories found matching 'build' 05:16:25 INFO - no previously-included directories found matching 'dist' 05:16:25 INFO - no previously-included directories found matching '.git*' 05:16:25 INFO - Successfully installed jsonschema functools32 05:16:25 INFO - Cleaning up... 05:16:25 INFO - Return code: 0 05:16:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:25 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 0x7faf8656df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23aadd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243d3d0>, '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 0x23a8ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a9360>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450790145.943476-374002784', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:16:25 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 05:16:25 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 05:16:25 INFO - Using env: {'DISPLAY': ':0', 05:16:25 INFO - 'HOME': '/home/cltbld', 05:16:25 INFO - 'LANG': 'en_US.UTF-8', 05:16:25 INFO - 'LANGUAGE': 'en_US:en', 05:16:25 INFO - 'LOGNAME': 'cltbld', 05:16:25 INFO - 'MAIL': '/var/mail/cltbld', 05:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:25 INFO - 'MOZ_NO_REMOTE': '1', 05:16:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:25 INFO - 'NO_EM_RESTART': '1', 05:16:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:25 INFO - 'PWD': '/builds/slave/test', 05:16:25 INFO - 'SHELL': '/bin/bash', 05:16:25 INFO - 'SHLVL': '1', 05:16:25 INFO - 'TERM': 'linux', 05:16:25 INFO - 'TMOUT': '86400', 05:16:25 INFO - 'USER': 'cltbld', 05:16:25 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450790145.943476-374002784', 05:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:25 INFO - '_': '/tools/buildbot/bin/python'} 05:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:25 INFO - Downloading/unpacking flake8 05:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:16:27 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 05:16:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:16:27 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 05:16:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:27 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 05:16:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:16:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:16:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:16:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:16:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:16:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:16:28 INFO - no previously-included directories found matching 'docs/_build' 05:16:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:16:28 INFO - Running setup.py install for pep8 05:16:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:16:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:16:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:16:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:16:28 INFO - no previously-included directories found matching 'docs/_build' 05:16:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:16:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:16:28 INFO - Cleaning up... 05:16:28 INFO - Return code: 0 05:16:28 INFO - Running post-action listener: _resource_record_post_action 05:16:28 INFO - Running post-action listener: _start_resource_monitoring 05:16:28 INFO - Starting resource monitoring. 05:16:28 INFO - ##### 05:16:28 INFO - ##### Running install step. 05:16:28 INFO - ##### 05:16:28 INFO - Running pre-action listener: _resource_record_pre_action 05:16:28 INFO - Running main action method: install 05:16:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:16:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:16:28 INFO - Reading from file tmpfile_stdout 05:16:28 INFO - Detecting whether we're running mozinstall >=1.0... 05:16:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:16:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:16:28 INFO - Reading from file tmpfile_stdout 05:16:28 INFO - Output received: 05:16:28 INFO - Usage: mozinstall [options] installer 05:16:28 INFO - Options: 05:16:28 INFO - -h, --help show this help message and exit 05:16:28 INFO - -d DEST, --destination=DEST 05:16:28 INFO - Directory to install application into. [default: 05:16:28 INFO - "/builds/slave/test"] 05:16:28 INFO - --app=APP Application being installed. [default: firefox] 05:16:28 INFO - mkdir: /builds/slave/test/build/application 05:16:28 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'] 05:16:28 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 05:16:44 INFO - Reading from file tmpfile_stdout 05:16:44 INFO - Output received: 05:16:44 INFO - /builds/slave/test/build/application/firefox/firefox 05:16:44 INFO - Running post-action listener: _resource_record_post_action 05:16:44 INFO - ##### 05:16:44 INFO - ##### Running run-tests step. 05:16:44 INFO - ##### 05:16:44 INFO - Running pre-action listener: _resource_record_pre_action 05:16:44 INFO - Running main action method: run_tests 05:16:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:16:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:16:44 INFO - Python 2.7.3 05:16:44 INFO - Return code: 0 05:16:44 INFO - grabbing minidump binary from tooltool 05:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:44 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 0x243d3d0>, '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 0x23a8ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a9360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:16:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:16:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:16:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:16:44 INFO - Return code: 0 05:16:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:16:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:16:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:16:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:16:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:16:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:16:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:16:45 INFO - Return code: 0 05:16:45 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/aWnEqmWcTTSAZB8hl6GKTw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:16:45 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/aWnEqmWcTTSAZB8hl6GKTw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:16:45 INFO - Using env: {'DISPLAY': ':0', 05:16:45 INFO - 'HOME': '/home/cltbld', 05:16:45 INFO - 'LANG': 'en_US.UTF-8', 05:16:45 INFO - 'LANGUAGE': 'en_US:en', 05:16:45 INFO - 'LOGNAME': 'cltbld', 05:16:45 INFO - 'MAIL': '/var/mail/cltbld', 05:16:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:16:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:16:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:45 INFO - 'MOZ_NO_REMOTE': '1', 05:16:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:16:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:45 INFO - 'NO_EM_RESTART': '1', 05:16:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:45 INFO - 'PWD': '/builds/slave/test', 05:16:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:16:45 INFO - 'SHELL': '/bin/bash', 05:16:45 INFO - 'SHLVL': '1', 05:16:45 INFO - 'TERM': 'linux', 05:16:45 INFO - 'TMOUT': '86400', 05:16:45 INFO - 'USER': 'cltbld', 05:16:45 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450790145.943476-374002784', 05:16:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:45 INFO - '_': '/tools/buildbot/bin/python'} 05:16:45 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/aWnEqmWcTTSAZB8hl6GKTw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:16:46 INFO - mozversion application_buildid: 20151222041117 05:16:46 INFO - mozversion application_changeset: 3cc8559d0d65d5704eedc72238a82c09b4b630cd 05:16:46 INFO - mozversion application_display_name: Nightly 05:16:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:16:46 INFO - mozversion application_name: Firefox 05:16:46 INFO - mozversion application_remotingname: firefox 05:16:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:16:46 INFO - mozversion application_vendor: Mozilla 05:16:46 INFO - mozversion application_version: 46.0a1 05:16:46 INFO - mozversion platform_buildid: 20151222041117 05:16:46 INFO - mozversion platform_changeset: 3cc8559d0d65d5704eedc72238a82c09b4b630cd 05:16:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:16:46 INFO - mozversion platform_version: 46.0a1 05:16:46 INFO - using testdate: 1450790206 05:16:46 INFO - actual date: 1450790206 05:16:46 INFO - starting webserver on 'localhost:54939' 05:16:46 INFO - SUITE-START | Running 3 tests 05:16:46 INFO - TEST-START | dromaeo_css 05:16:46 INFO - operating with platform_type : linux_ 05:16:46 INFO - Initialising browser for dromaeo_css test... 05:16:46 INFO - TEST-INFO | started process 3358 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk7d3hr/profile http://localhost:54939/getInfo.html) 05:16:51 INFO - PROCESS | 3358 | __metrics Screen width/height:1600/1200 05:16:51 INFO - PROCESS | 3358 | colorDepth:24 05:16:51 INFO - PROCESS | 3358 | Browser inner width/height: 1024/697 05:16:51 INFO - PROCESS | 3358 | __metrics 05:16:51 INFO - PROCESS | 3358 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:16:51 INFO - PROCESS | 3358 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:16:52 INFO - TEST-INFO | 3358: exit 0 05:16:52 INFO - Browser initialized. 05:16:52 INFO - Running cycle 1/1 for dromaeo_css test... 05:16:52 INFO - TEST-INFO | started process 3450 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk7d3hr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:04 INFO - PROCESS | 3450 | RSS: Main: 150061056 05:17:04 INFO - PROCESS | 3450 | 05:17:55 INFO - PROCESS | 3450 | 1450790275947 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:20:08 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:54939/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54939/tests/dromaeo/cssquery-ext.html) 05:20:09 INFO - PROCESS | 3450 | RSS: Main: 256098304 05:20:09 INFO - PROCESS | 3450 | 05:23:11 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:54939/tests/dromaeo/cssquery-ext.html (next: http://localhost:54939/tests/dromaeo/cssquery-jquery.html) 05:23:12 INFO - PROCESS | 3450 | RSS: Main: 229228544 05:23:12 INFO - PROCESS | 3450 | 05:26:14 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:54939/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54939/tests/dromaeo/cssquery-mootools.html) 05:26:15 INFO - PROCESS | 3450 | RSS: Main: 225447936 05:26:15 INFO - PROCESS | 3450 | 05:29:17 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:54939/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54939/tests/dromaeo/cssquery-prototype.html) 05:29:17 INFO - PROCESS | 3450 | RSS: Main: 210472960 05:29:17 INFO - PROCESS | 3450 | 05:32:20 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:54939/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54939/tests/dromaeo/cssquery-yui.html) 05:32:20 INFO - PROCESS | 3450 | RSS: Main: 215007232 05:32:20 INFO - PROCESS | 3450 | 05:35:23 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:54939/tests/dromaeo/cssquery-yui.html (next: http://localhost:54939/tests/dromaeo/cssquery-dojo.html) 05:35:23 INFO - PROCESS | 3450 | RSS: Main: 260116480 05:35:23 INFO - PROCESS | 3450 | 05:35:23 INFO - PROCESS | 3450 | __start_tp_report 05:35:23 INFO - PROCESS | 3450 | _x_x_mozilla_page_load 05:35:23 INFO - PROCESS | 3450 | _x_x_mozilla_page_load_details 05:35:23 INFO - PROCESS | 3450 | |i|pagename|runs| 05:35:23 INFO - PROCESS | 3450 | |0;dojo.html;2595.0917178987356;2646.722094180111;2657.229403472993;2669.6929853066904;2688.7983401244906;4410.338449232617;4529.524399938008;4570.10882877839;4602.838900638479;4628.976855115724;4550.226461501545;4566.31505274209;4625.537446255373;4626.144163329778;4696.272077827934;4294.592013758688;4298.828046878121;4303.935440968388;4304.720193187449;4351.5648435156545;4118.073433477473;4333.848315308965;4349.652027837781;4414.580614841585;4420.226460369438;4166.979165104155;4243.575642435762;4269.67977401693;4299.72051816634;4324.156789426063;4340.956590434118;4343.1747967886;4343.869683909456;4344.413504176959;4388.758618275993;4338.197433474786;4344.022594916119;4345.826166953318;4366.8034938427845;4405.11897620474;4388.71473354231;4420.911581768347;4476.507584165739;4497.168023915553;4543.1140927519145;4936.432310284327;4945.258211268302;4951.653384263103;4952.62855285855;4982.750862456863;4963.032208719301;4965.0566392385335;4969.627277954168;4970.353853998993;4983.775730092155;4541.091781643651;4573.885652858705;4656.068786242698;4657.371254880582;4693.507181745936;5096.541311282002;5165.173572228426;5166.018456493254;5183.844484665466;5193.1171700810955;4964.056829202512;4981.103401387712;4985.52637499437;5030.572401345853;5031.547160755549;4719.315699223594;4827.444843842933;4829.517048295213;4841.515848415201;4943.036107958914;4901.705897646081;4935.876603084952;4937.23472861707;4947.90104197914;4994.126027945095;4915.631327650441;4917.975410122926;4927.95072049282;4930.605551555867;4974.204127339608;4056.411820286042;4117.279476091672;4150.792460376969;4201.117765269267;4216.683748718859;3683.3369993401443;3719.628037196259;3721.776693398405;3742.4760533525327;3758.7180961428003;4324.329728892027;4342.848000319974;4347.7614676171825;4348.369486424451;4391.3412988051405;4734.763261836894;4807.230843065093;4855.295982082649;4892.902141957141;4975.278584605212;4270.530241673413;4279.914401711948;4295.785210739513;4312.870613881589;4327;4448.755318457451;4464.665150113755;4471.083427897273;4473.821047158142;4515.435570553681;4517.164324599959;4621.2837010263465;4623.583877451046;4712.481627021093;4747.098051370229;4859.8299059534165;4945.901081978413;4946.258061290835;4963.528464795839;5007.524285192901;4733.029728905635;4742.905141897074;4744.240921452551;4748.0978614063215;4777.593904518016;4752.738599377068;4897.020595880766;4897.045076210247;4921.212605983169;4979.800807967641;4860.0279944012045;4917.385326834145;4921.729304888266;4924.630652701134;4974.651774375759;4813.350197723263;4860.392450943632;4871.585915197106;4876.4392094909535;4907.141250281115;4585.679002469795;4727.692699974491;4731.479537250969;4856.125897338513;4903.95096049035;4672.369230153886;4728;4737.857864264078;4745.4542727585385;4787.904241915073;4932.284818701197;4960.255961605788;4963.429205641398;4964.702117872939;4965.826196083264;4578.908421831611;4659.34769132315;4702.03608260299;4841.163355595535;4852.490488498657 05:35:23 INFO - PROCESS | 3450 | |1;ext.html;571.8799052199038;571.9685417302048;579.7130420441882;585.9423740149032;593.9991114971272;24647.13735019275;32435.83782081089;32940.50589241163;32962.50556241658;33026.174345641404;38915.41626875592;39672.80163599178;39752.20495590087;39756.80121599388;39837;6877.415419689332;6983.615901125436;7796.649150788228;7960;7962.800929976739;10044.146247568966;10154.136898363611;10224.539895704711;10225.693229203098;10234.283600147992;9784.119429251366;9889.357191782512;9892.950535247313;9894.109530142287;9895.356801807895;7084.787456376317;7215.783526494213;7252.637368131625;7252.782416527512;9759.560819763128;10074.848877266846;10377.688669339932;10384.480775961172;10394.116500097502;10403.84394234087;36092.45861312083;36406.453903191476;36423;36457.270854583025;36490.63509364899;2814.7185281471893;2863.3700585871075;2868.6270784797844;3342.715869151125;3636.799976001319;27106.300095146427;27356.58965115525;27504.724952750417;27592.862035689694;27822.86088569544;3278.5737854079057;3340.1315657929113;3341.231516751161;3345.2974875276223;3467.219875527986;209214;211808.94095529578;212215;212580;212592;49576.50423495791;53578;53583;53717.73141134269;54035.729821350644;43897.12205755931;63105;64822;64838.35161648417;64839;13100.672483187996;13232.867671323356;13233.735325293634;13236.669083272995;13250.204987700768;11201;11277.436128193558;11333.546658133748;11347.546098156146;11349.375784331776;18265.360712375004;18385.448436546925;18427.63144737098;18580.44258672242;18603.720944185578;7421.962890185622;7631.809204769926;7668;7713.9200511928375;7814;802.7993001749562;819.8893149424871;839.6305625524872;862.8015556422058;904.421170450912;24286.635700464507;24471.265862024167;25000.4999900001;25243.242702718948;25259.368515787253;902.3548163063441;923.9168474837297;932.1983094538691;989.6882482018141;992.7319623701704;13034.80447793284;13054.738905221842;13143.277119758504;13206.867931320756;13227.735445291233;290670;291624;294350;296682;297363;43712;44360;44366.77816610896;44369.334459983125;44392;1155.0874808900874;1157.3229660648615;1168.9473973671375;1180.7933611617932;1182.9526818927147;23757.406064848517;25003.87498062498;29427.057294270402;29526.704732952396;30791.69208307978;41569.58430415657;41771.7911410441;42116.78941605272;42120.578794211666;42188.78905605452;231723;232808;234555;236645;238193;33365.49951750774;35034.474482883285;37119.07202319964;41112.58887411088;41510.79244603758;35829.28341433105;35997.1000724984;36708.81645591755;36734;37286;32228.516572251905;32441.188970275933;32892.83553582217;33238.50142247917;33324.333513330086;28289.00377113393;32564.51153232751;32650.51024234591;34087.48868766921;38143.23713525658;31476;31827.6817231834;31835.522467162547;31918.840405797822;32097;27655.723442765317;29970.14688525922;30606.234844129074;33404.66595334113;35007.29985400227;23132.884335578216;23269.650955235345;24062.87968560146;24273.271801845975;24697 05:35:23 INFO - PROCESS | 3450 | |2;jquery.html;337.5561137104707;339.755376129187;340.67295396419433;341.118209428627;341.515048630944;12640.747185056294;13082.280474573894;15020.924895375521;15091.471798487042;15747.370105195792;12890.935545322283;13128.015398845077;14524.709505809877;14953.626159346022;15648.295826687798;4861.343718597988;5024.246363045536;5042.3949126104735;5043.193089105744;5047.041062198189;3775.093977445421;3893.4743809585766;4959.826406075788;5000.874978125539;5008.073506401327;5538.667679939196;5674.858128546778;5706.400827913071;5711.143328500737;5715.1998720179;5537.169424586304;5665.886682266352;5673.971630141864;5695.829125126212;5702.54379649627;5105.923411148836;5126.820561280338;5131.897362052775;5136.203888397305;5138.614603904684;18462.815371846245;18700.345487907995;18899.433017009513;18903.90548047251;19127.80872191274;1818.7453756474104;1855.471190710641;1903.961920761577;1910.1977169588667;2247.1573160064977;12310.076744244217;12477.188982716094;12540.372981350987;12788.209650648916;12953;1726.9913650431668;1732.644807814395;1739.6607661506011;1789.150153677006;1820.5721655410969;51446;53284.20073698936;54403.72798135984;55044.44955550433;55582.16626750602;9120.908790912139;9216.354855160209;9378.062193780568;9385.155336019654;9423.48170850596;12016.218945768496;12020.218685785396;12047.096467764954;12054.276743395425;12076.154669173073;7147.678354474061;7218;7220.638968051577;7249.565026098451;7353.522021068614;7145.642717864086;7147.857042859114;7159.498835081495;7237.167725711611;7244.818879528054;5672.404397538282;5693.658380497183;5699.914501282484;5726.284214473191;5726.828195154152;1516.4616561120863;1580.4310448238625;1633.55893908644;1654.1067823375483;1665.8001039875292;834.1283358889974;853.125546315032;856.3791251342726;901.3735453859505;945.5272363818091;14858.851411485746;15588.220588970506;15629.921850390903;16032.679346413239;16269.267882945296;758.7192738686721;838.9244967952792;888.7911340834899;924.6763632728625;947.313197931508;8221.342292616577;8612.009618893908;8802.735917922344;9553.140217380469;9591.856122158173;448636;450228;453218;475449;480550;64588;69647.65176174087;69702.30297696959;69924.6503767488;69931.65034174899;1036.8341065429495;1056.2975621211808;1056.3186744549723;1068.326954018963;1091.0998426298336;14840.257987100818;14843.109413435228;14971.700565988836;15029.849701502844;15169.469068582988;32360.83819580887;33310.333793323516;33553.83223083869;33573.32853342968;33952.320953580296;41669;43424.56575434205;44163.77918110389;45085.32372014357;46985.76507117443;8422.368322375723;8886.600102995251;9002;9007.774805629911;9107.544622768703;10312.845307320245;10319.587216511256;10410;10420.218483613608;10484.056434920894;12575.182613130117;13183.868161318263;13455.596332110052;13567.796483052565;13607.931960340135;12077.939610301892;12465.314407707663;12543.310117943236;12725.61823145307;12746.171498852545;10747.946260268649;13233.602991910258;13296.534621288209;13794.517191898236;13834.792478112635;8784.868226976472;8833.33749968742;8838.867416988622;8887;8910.618854077627;13640.590782276548;13814.447422103003;14012.299385030503;14176.291185440892;14335.85664143387 05:35:23 INFO - PROCESS | 3450 | |3;mootools.html;1323.477226495535;1543.621812655899;1665.7085010123226;1685.2079522624363;1722.3024675006618;5717.571182161339;6673.9666301668485;6803.353681400259;6819.693113809878;6824.215215250248;6845.247022827485;7004;7007.474439417038;7008.159020917497;7019.087518622585;2029.4419034765483;2070.3581889614193;2070.554830711397;2073.460900165953;2074.4917495213695;2041.591681663666;2043.407411850569;2054.856160068796;2065.452655046414;2067.4417907165057;1962.4995626115392;1986.6026794641057;2011.4468521156653;2015.7278767366438;2016.67733162694;2027.4627223785708;2049.600327936053;2056.393363957636;2057.5473395852887;2058.5265388960547;2018.1826360323946;2054.8253398460997;2054.8253398461147;2057.897105144737;2059.124871929439;6861.622610756406;6935.653217339112;6936.4797640176685;6940.479464040217;6946.444284457231;4006.8380169750735;4063.9593604063875;4076.735012224196;4091.488563929509;4101.364288535282;2557.309526427854;2604;2611.973880261211;2612.542805009116;2635.3279913622096;873.6461732998082;879.8284334554764;887.3389324952951;898.8876390451194;908.895477020138;9343.953280233556;9366.063393660648;9370.765730856714;9382.202512786422;9390.5304734763;3662.468942003448;3670.6785557199387;3740.2519496100344;3743.5320584926885;3745.4007358823;7992.640331185111;8004.119546849842;8012.1186669466315;8014.078380986261;8017.4387792855105;4141.875743727693;4161.10536234711;4169.395437661583;4171.207470580641;4186.623203911662;3226.596675415573;3318.5685860837934;3601.9279614408088;3772.0946972726897;3794.772313661189;3223.3553289341758;3248.3503299340227;3276.3938671345877;3300.6369299377047;3319.55186049885;1005.5123265216364;1007.596961215505;1014.0467960117466;1015;1016.8576399304103;1122.7978963786434;1146.266389510714;1152.4986630815622;1152.608113241502;1161.5063597970998;6441.806745797634;6495.512836537184;6512;6520.282768895418;6528.738850445929;398.9740666856645;406.28899426004494;406.8392984770999;407.1084325327523;407.1307757936767;5190.2214667800135;5221.295125158131;5239.44985776488;5239.44985776488;5243.134882744381;8205.179482051746;8239.876401853977;8245.917540824636;8358.289545388589;8415.779711941734;8205.835883282301;8251.257386835214;8255.587220638945;8293.087760346478;8355.289800366916;6464.127342808661;6575.914974029231;6617.205935287796;6633.369829866155;6641.601503909781;6330.303666596763;6351.777687780906;6355.841103972438;6357.205349331333;6360.4911607072245;6935.653217339213;7276.890846637199;7422.740204092831;7477.4391920605085;7494.6252687366505;7364.742234021784;7566.1298950621385;7577.659005344663;7735.381169506313;7849.568273744999;5169.095408303607;5416.350037995308;6200.689965501617;6268.4671802897265;6278.497720182466;6319.873602528016;6454.5159113065765;6463.64449955257;6478.222613286436;6486.383793539606;5890.764369425175;5952.166696662384;6012.338642749207;6087.147799308189;6116.66358350295;6022.728977196124;6119.479844213113;6163.229596300463;6170.969145154246;6220.253569571681;5915.763369465345;6050.21347224858;6053.939460605337;6069.0289553672965;6101.420365065312;5873.970630146822;5931.822045338647;5936.13925980739;5937.317208521075;5939.3466718661775;5902.5277977762535;5983.922893879144;6066.181065556093;6086.634801911722;6110.969445152746 05:35:23 INFO - PROCESS | 3450 | |4;prototype.html;296.71218917649884;296.8960863697707;301.83097465419365;302.15848860922324;305.0588933141259;5244.606654500918;5309.469053094688;5353.0096932067545;5404.000259951912;5413.810516631918;5230.476952304777;5293.682379057259;5294.52349288564;5299.894002119955;5302.893942121155;3935.7638541687447;4152.2941100012995;4165.83336666533;4170.9582904170875;4174.958250417502;3950.7036972227197;4027.597240275978;4076.694247931402;4077.87766367008;4089.9182016359805;4008.6592639625665;4020.095478517325;4025.2754504189234;4035.829609413281;4042.73722208057;3782.413725872494;3857.189990102082;3932.7640341579313;4015.0765323975647;4019.718619696622;3561.465780132975;3570.5715314162467;3571.928561428757;3572.732045096602;3575.606683264865;5057.367829021372;5057.519535644108;5076.238564215398;5078;5080.593552515827;4672.415948006499;4675.649326300541;4683.953160468386;4685.688007357945;4686;5400.297961265011;5546.362168350651;5573.888522229533;5577.330720313588;5615.747291371898;3853.537575490931;3854.4025676019983;3856.749311294757;3861.2470568239205;3861.7876016819064;5841.065429531254;5926.081457374071;5926.940730592682;5927.555433342516;5933.821985340403;3996.2407142642805;3999.92000160001;4001.8199181036925;4005.1989602079702;4022.1754540319166;3886;4055;4055.7160998730396;4064.4919385076864;4069;4663.533646635309;4674.158651442773;4678.064387122589;4678.415198100238;4678.578927896438;5605.271314729141;5607.467290607386;5609.943900561024;5614.157876318503;5615.129654903415;1410.0975375759522;1430.7853821926794;1431.0912570517587;1431.3487363249697;1432.44134787433;949.7910459698855;953.1136043479491;955.4362925873768;975.7170420578095;980.8087422952456;4921;4928.926066109011;4930.876728081755;4934.629902757308;4937.432195297515;5772.826815195551;5776.971115144482;5778.855528611818;5782.653040817564;5782.797602083907;4928.457869634337;4930.11257973561;4930.6795058321095;4936.259561065797;4941.061198372297;3055.0682041976966;3099.3336432666633;3133.263683034485;3135.059482155344;3138.340948400861;5542;5586.804461843816;5594.776208951596;5597.384287728347;5600.607957443021;5981.132735753292;5983.401659833982;5995.100734889801;6056.970315046365;6070.119832624245;5506.256655351556;5508.91736623951;5534.335879694462;5556.805511807067;5568.081266591048;5668.801591944262;5834.474897259267;5839.153322768259;5839.357670656309;5843.2695913010875;5720.914186287126;5724.398938111438;5725.112607545837;5736.225609542826;5744.626599271034;5538.501534861882;5540.196671482532;5543.972280138573;5547.639403438763;5547.805826796042;3827.9234415312094;3871.380579107329;3899.5515515716056;3922.941155882607;3924.6860251179264;5857.619254748598;5864.149698293638;5865.384134665969;5866.67733274674;5871.2073870027;5605.32736071674;5652.293463317085;5654.802081927277;5656.095024796013;5658.660480371191;5602.971985140048;5610.410906854721;5613.691246981455;5619.044762390322;5620.522255608155;5306.071437498499;5440.238366628596;5442.510174084351;5467.097928841697;5484.972575137099;5374.0864053111845;5504.53211477029;5628.493435590816;5645.266115404971;5661.377248502579;5367.758450869798;5424.674519528841;5425.620206585501;5430.348358197041;5439.891202176013 05:35:23 INFO - PROCESS | 3450 | |5;yui.html;678.4572342126298;735.9080114985624;770.7918861907282;773.9729109481168;799.6121880887769;11154.10767138629;11345.319280843156;11402.828957565644;11416.942915285432;11426.257293275941;10462.42456664885;10963.56145754171;10982.835257471124;11010.559577616907;11017;612.8130920069377;778.0274656679151;791.5685951156634;792.1049214387763;792.2552800367636;774.8605251054807;789.826238227589;792.7819849541364;792.7978365516785;793.2226418110256;640.9839754006141;647.4949539359308;814.4380377539479;825.4923222218323;834.3867257565685;819.0785366462729;819.9508029518219;820.9876851847227;821.1747194069981;821.4906757810136;607.4350853706052;608.191105829246;608.4493533352323;608.580079744979;608.6713174885557;11515.654530364103;11547.884521154765;11602.477888495037;11610.129240307011;11614.245074070159;10779.137668986541;11029.227954043221;11082.168837337233;11214.10287177024;11540.596079137275;8951.507667078307;8975.775605609846;9284.907150928471;9289.907100928971;9290;3231.757618178646;3315.900522984314;3319.369319829225;3322.1196382958537;3386.204242003152;36408.992516234786;36533.45199822005;36749.44875826865;36877.26245475102;37082.07294817624;9050.502222377701;9160.541972901328;9226.49254291007;9307.90692093084;9475.526223688788;16127.516174514783;16130.435434759727;16208.270627821776;16208.918955405148;16210.270537825827;6249.593776404519;6327.240731112204;6446.7421303148285;6573.342665733484;6788.558743681645;3635.4546817976984;3693.575238847513;3699.6855267302044;3707.88876333705;3710.2023065040607;2576.291519832061;2594.9351266218496;2605.71337152913;2611.229687242268;2612.6342312076326;478.5477723551211;495.44757595281004;501.7516329416962;507.0366304022387;512.8358925143992;505.8381317978285;565.3046752494373;579.4900487570994;580.6167929166729;589.4576989169974;7208.675609597581;7394.55632662042;7552.811179720551;7555.244475552401;7571.3942884569105;541.8374487653688;576.7577617400701;581.6306645280278;605.7032054293364;619.3434958943534;3321.335732853439;3508.333416650828;3509.298140371936;3616.5840928293055;3630.618785027587;44358;45536;45700.08599827985;45700.771496142304;45845.31232031522;40320.39519407211;41621.79189104035;41757.37363939543;41757.791211043754;41926.79036604797;36527.26945461076;37037.44443833291;37435.62564374322;37520;37656;7018.684159212949;7033;7074.964625176841;7153.105861767279;7293.671784769805;29369.7063029367;29670.406591868472;29808.254793630334;29822.701772982862;30188.84905575458;33916.83041584776;34087.65912340845;34421.48367774535;37714.622853772205;37740.2451950965;8738.388312818295;8926.553672316488;9059.954700226457;9075.455472671661;9139.954300228723;9506.429614223169;9664.323497355117;9762.804743905224;9878.179417553183;9921.305508614329;9001.819963600823;9163.633454661738;9235.676751313671;9363.625454981724;9487.620495180116;9324.347295689236;9380.953095234754;9417.152456278967;9421.81156376855;9423.717288481357;9365.625374984924;9511.619535218513;9541.952290238505;9552.42685438876;9585.185259253041;8064.274215320649;8080.232377924088;8084.838303233785;8202.384821138558;8321.251087402163;7171.8565628688175;7505.099388073248;7641.808954776175;7660.233976602295;7696.422768292512 05:35:23 INFO - PROCESS | 3450 | __end_tp_report 05:35:23 INFO - PROCESS | 3450 | __start_cc_report 05:35:23 INFO - PROCESS | 3450 | _x_x_mozilla_cycle_collect,875 05:35:23 INFO - PROCESS | 3450 | __end_cc_report 05:35:23 INFO - PROCESS | 3450 | __startTimestamp1450791323674__endTimestamp 05:35:23 INFO - PROCESS | 3450 | 05:35:23 INFO - PROCESS | 3450 | ------- Summary: start ------- 05:35:23 INFO - PROCESS | 3450 | Number of tests: 6 05:35:23 INFO - PROCESS | 3450 | 05:35:23 INFO - PROCESS | 3450 | [#0] dojo.html Cycles:165 Average:4586.31 Median:4702.04 stddev:465.50 (9.9%) stddev-sans-first:439.94 05:35:23 INFO - PROCESS | 3450 | Values: 2595.1 2646.7 2657.2 2669.7 2688.8 4410.3 4529.5 4570.1 4602.8 4629.0 4550.2 4566.3 4625.5 4626.1 4696.3 4294.6 4298.8 4303.9 4304.7 4351.6 4118.1 4333.8 4349.7 4414.6 4420.2 4167.0 4243.6 4269.7 4299.7 4324.2 4341.0 4343.2 4343.9 4344.4 4388.8 4338.2 4344.0 4345.8 4366.8 4405.1 4388.7 4420.9 4476.5 4497.2 4543.1 4936.4 4945.3 4951.7 4952.6 4982.8 4963.0 4965.1 4969.6 4970.4 4983.8 4541.1 4573.9 4656.1 4657.4 4693.5 5096.5 5165.2 5166.0 5183.8 5193.1 4964.1 4981.1 4985.5 5030.6 5031.5 4719.3 4827.4 4829.5 4841.5 4943.0 4901.7 4935.9 4937.2 4947.9 4994.1 4915.6 4918.0 4928.0 4930.6 4974.2 4056.4 4117.3 4150.8 4201.1 4216.7 3683.3 3719.6 3721.8 3742.5 3758.7 4324.3 4342.8 4347.8 4348.4 4391.3 4734.8 4807.2 4855.3 4892.9 4975.3 4270.5 4279.9 4295.8 4312.9 4327.0 4448.8 4464.7 4471.1 4473.8 4515.4 4517.2 4621.3 4623.6 4712.5 4747.1 4859.8 4945.9 4946.3 4963.5 5007.5 4733.0 4742.9 4744.2 4748.1 4777.6 4752.7 4897.0 4897.0 4921.2 4979.8 4860.0 4917.4 4921.7 4924.6 4974.7 4813.4 4860.4 4871.6 4876.4 4907.1 4585.7 4727.7 4731.5 4856.1 4904.0 4672.4 4728.0 4737.9 4745.5 4787.9 4932.3 4960.3 4963.4 4964.7 4965.8 4578.9 4659.3 4702.0 4841.2 4852.5 05:35:23 INFO - PROCESS | 3450 | 05:35:23 INFO - PROCESS | 3450 | [#1] ext.html Cycles:180 Average:40936.24 Median:32951.51 stddev:64993.15 (197.2%) stddev-sans-first:65104.81 05:35:23 INFO - PROCESS | 3450 | Values: 571.9 572.0 579.7 585.9 594.0 24647.1 32435.8 32940.5 32962.5 33026.2 38915.4 39672.8 39752.2 39756.8 39837.0 6877.4 6983.6 7796.6 7960.0 7962.8 10044.1 10154.1 10224.5 10225.7 10234.3 9784.1 9889.4 9893.0 9894.1 9895.4 7084.8 7215.8 7252.6 7252.8 9759.6 10074.8 10377.7 10384.5 10394.1 10403.8 36092.5 36406.5 36423.0 36457.3 36490.6 2814.7 2863.4 2868.6 3342.7 3636.8 27106.3 27356.6 27504.7 27592.9 27822.9 3278.6 3340.1 3341.2 3345.3 3467.2 209214.0 211808.9 212215.0 212580.0 212592.0 49576.5 53578.0 53583.0 53717.7 54035.7 43897.1 63105.0 64822.0 64838.4 64839.0 13100.7 13232.9 13233.7 13236.7 13250.2 11201.0 11277.4 11333.5 11347.5 11349.4 18265.4 18385.4 18427.6 18580.4 18603.7 7422.0 7631.8 7668.0 7713.9 7814.0 802.8 819.9 839.6 862.8 904.4 24286.6 24471.3 25000.5 25243.2 25259.4 902.4 923.9 932.2 989.7 992.7 13034.8 13054.7 13143.3 13206.9 13227.7 290670.0 291624.0 294350.0 296682.0 297363.0 43712.0 44360.0 44366.8 44369.3 44392.0 1155.1 1157.3 1168.9 1180.8 1183.0 23757.4 25003.9 29427.1 29526.7 30791.7 41569.6 41771.8 42116.8 42120.6 42188.8 231723.0 232808.0 234555.0 236645.0 238193.0 33365.5 35034.5 37119.1 41112.6 41510.8 35829.3 35997.1 36708.8 36734.0 37286.0 32228.5 32441.2 32892.8 33238.5 33324.3 28289.0 32564.5 32650.5 34087.5 38143.2 31476.0 31827.7 31835.5 31918.8 32097.0 27655.7 29970.1 30606.2 33404.7 35007.3 23132.9 23269.7 24062.9 24273.3 24697.0 05:35:23 INFO - PROCESS | 3450 | 05:35:23 INFO - PROCESS | 3450 | [#2] jquery.html Cycles:180 Average:25509.64 Median:3834.28 stddev:75398.69 (1966.4%) stddev-sans-first:75586.51 05:35:23 INFO - PROCESS | 3450 | Values: 337.6 339.8 340.7 341.1 341.5 12640.7 13082.3 15020.9 15091.5 15747.4 12890.9 13128.0 14524.7 14953.6 15648.3 4861.3 5024.2 5042.4 5043.2 5047.0 3775.1 3893.5 4959.8 5000.9 5008.1 5538.7 5674.9 5706.4 5711.1 5715.2 5537.2 5665.9 5674.0 5695.8 5702.5 5105.9 5126.8 5131.9 5136.2 5138.6 18462.8 18700.3 18899.4 18903.9 19127.8 1818.7 1855.5 1904.0 1910.2 2247.2 12310.1 12477.2 12540.4 12788.2 12953.0 1727.0 1732.6 1739.7 1789.2 1820.6 51446.0 53284.2 54403.7 55044.4 55582.2 9120.9 9216.4 9378.1 9385.2 9423.5 12016.2 12020.2 12047.1 12054.3 12076.2 7147.7 7218.0 7220.6 7249.6 7353.5 7145.6 7147.9 7159.5 7237.2 7244.8 5672.4 5693.7 5699.9 5726.3 5726.8 1516.5 1580.4 1633.6 1654.1 1665.8 834.1 853.1 856.4 901.4 945.5 14858.9 15588.2 15629.9 16032.7 16269.3 758.7 838.9 888.8 924.7 947.3 8221.3 8612.0 8802.7 9553.1 9591.9 448636.0 450228.0 453218.0 475449.0 480550.0 64588.0 69647.7 69702.3 69924.7 69931.7 1036.8 1056.3 1056.3 1068.3 1091.1 14840.3 14843.1 14971.7 15029.8 15169.5 32360.8 33310.3 33553.8 33573.3 33952.3 41669.0 43424.6 44163.8 45085.3 46985.8 8422.4 8886.6 9002.0 9007.8 9107.5 10312.8 10319.6 10410.0 10420.2 10484.1 12575.2 13183.9 13455.6 13567.8 13607.9 12077.9 12465.3 12543.3 12725.6 12746.2 10747.9 13233.6 13296.5 13794.5 13834.8 8784.9 8833.3 8838.9 8887.0 8910.6 13640.6 13814.4 14012.3 14176.3 14335.9 05:35:23 INFO - PROCESS | 3450 | 05:35:23 INFO - PROCESS | 3450 | [#3] mootools.html Cycles:180 Average:4808.11 Median:5945.76 stddev:2502.86 (42.1%) stddev-sans-first:2496.18 05:35:23 INFO - PROCESS | 3450 | Values: 1323.5 1543.6 1665.7 1685.2 1722.3 5717.6 6674.0 6803.4 6819.7 6824.2 6845.2 7004.0 7007.5 7008.2 7019.1 2029.4 2070.4 2070.6 2073.5 2074.5 2041.6 2043.4 2054.9 2065.5 2067.4 1962.5 1986.6 2011.4 2015.7 2016.7 2027.5 2049.6 2056.4 2057.5 2058.5 2018.2 2054.8 2054.8 2057.9 2059.1 6861.6 6935.7 6936.5 6940.5 6946.4 4006.8 4064.0 4076.7 4091.5 4101.4 2557.3 2604.0 2612.0 2612.5 2635.3 873.6 879.8 887.3 898.9 908.9 9344.0 9366.1 9370.8 9382.2 9390.5 3662.5 3670.7 3740.3 3743.5 3745.4 7992.6 8004.1 8012.1 8014.1 8017.4 4141.9 4161.1 4169.4 4171.2 4186.6 3226.6 3318.6 3601.9 3772.1 3794.8 3223.4 3248.4 3276.4 3300.6 3319.6 1005.5 1007.6 1014.0 1015.0 1016.9 1122.8 1146.3 1152.5 1152.6 1161.5 6441.8 6495.5 6512.0 6520.3 6528.7 399.0 406.3 406.8 407.1 407.1 5190.2 5221.3 5239.4 5239.4 5243.1 8205.2 8239.9 8245.9 8358.3 8415.8 8205.8 8251.3 8255.6 8293.1 8355.3 6464.1 6575.9 6617.2 6633.4 6641.6 6330.3 6351.8 6355.8 6357.2 6360.5 6935.7 7276.9 7422.7 7477.4 7494.6 7364.7 7566.1 7577.7 7735.4 7849.6 5169.1 5416.4 6200.7 6268.5 6278.5 6319.9 6454.5 6463.6 6478.2 6486.4 5890.8 5952.2 6012.3 6087.1 6116.7 6022.7 6119.5 6163.2 6171.0 6220.3 5915.8 6050.2 6053.9 6069.0 6101.4 5874.0 5931.8 5936.1 5937.3 5939.3 5902.5 5983.9 6066.2 6086.6 6111.0 05:35:23 INFO - PROCESS | 3450 | 05:35:23 INFO - PROCESS | 3450 | [#4] prototype.html Cycles:180 Average:4632.58 Median:5304.48 stddev:1379.37 (26.0%) stddev-sans-first:1344.30 05:35:23 INFO - PROCESS | 3450 | Values: 296.7 296.9 301.8 302.2 305.1 5244.6 5309.5 5353.0 5404.0 5413.8 5230.5 5293.7 5294.5 5299.9 5302.9 3935.8 4152.3 4165.8 4171.0 4175.0 3950.7 4027.6 4076.7 4077.9 4089.9 4008.7 4020.1 4025.3 4035.8 4042.7 3782.4 3857.2 3932.8 4015.1 4019.7 3561.5 3570.6 3571.9 3572.7 3575.6 5057.4 5057.5 5076.2 5078.0 5080.6 4672.4 4675.6 4684.0 4685.7 4686.0 5400.3 5546.4 5573.9 5577.3 5615.7 3853.5 3854.4 3856.7 3861.2 3861.8 5841.1 5926.1 5926.9 5927.6 5933.8 3996.2 3999.9 4001.8 4005.2 4022.2 3886.0 4055.0 4055.7 4064.5 4069.0 4663.5 4674.2 4678.1 4678.4 4678.6 5605.3 5607.5 5609.9 5614.2 5615.1 1410.1 1430.8 1431.1 1431.3 1432.4 949.8 953.1 955.4 975.7 980.8 4921.0 4928.9 4930.9 4934.6 4937.4 5772.8 5777.0 5778.9 5782.7 5782.8 4928.5 4930.1 4930.7 4936.3 4941.1 3055.1 3099.3 3133.3 3135.1 3138.3 5542.0 5586.8 5594.8 5597.4 5600.6 5981.1 5983.4 5995.1 6057.0 6070.1 5506.3 5508.9 5534.3 5556.8 5568.1 5668.8 5834.5 5839.2 5839.4 5843.3 5720.9 5724.4 5725.1 5736.2 5744.6 5538.5 5540.2 5544.0 5547.6 5547.8 3827.9 3871.4 3899.6 3922.9 3924.7 5857.6 5864.1 5865.4 5866.7 5871.2 5605.3 5652.3 5654.8 5656.1 5658.7 5603.0 5610.4 5613.7 5619.0 5620.5 5306.1 5440.2 5442.5 5467.1 5485.0 5374.1 5504.5 5628.5 5645.3 5661.4 5367.8 5424.7 5425.6 5430.3 5439.9 05:35:23 INFO - PROCESS | 3450 | 05:35:23 INFO - PROCESS | 3450 | [#5] yui.html Cycles:180 Average:11350.31 Median:608.32 stddev:12655.66 (2080.4%) stddev-sans-first:12665.79 05:35:23 INFO - PROCESS | 3450 | Values: 678.5 735.9 770.8 774.0 799.6 11154.1 11345.3 11402.8 11416.9 11426.3 10462.4 10963.6 10982.8 11010.6 11017.0 612.8 778.0 791.6 792.1 792.3 774.9 789.8 792.8 792.8 793.2 641.0 647.5 814.4 825.5 834.4 819.1 820.0 821.0 821.2 821.5 607.4 608.2 608.4 608.6 608.7 11515.7 11547.9 11602.5 11610.1 11614.2 10779.1 11029.2 11082.2 11214.1 11540.6 8951.5 8975.8 9284.9 9289.9 9290.0 3231.8 3315.9 3319.4 3322.1 3386.2 36409.0 36533.5 36749.4 36877.3 37082.1 9050.5 9160.5 9226.5 9307.9 9475.5 16127.5 16130.4 16208.3 16208.9 16210.3 6249.6 6327.2 6446.7 6573.3 6788.6 3635.5 3693.6 3699.7 3707.9 3710.2 2576.3 2594.9 2605.7 2611.2 2612.6 478.5 495.4 501.8 507.0 512.8 505.8 565.3 579.5 580.6 589.5 7208.7 7394.6 7552.8 7555.2 7571.4 541.8 576.8 581.6 605.7 619.3 3321.3 3508.3 3509.3 3616.6 3630.6 44358.0 45536.0 45700.1 45700.8 45845.3 40320.4 41621.8 41757.4 41757.8 41926.8 36527.3 37037.4 37435.6 37520.0 37656.0 7018.7 7033.0 7075.0 7153.1 7293.7 29369.7 29670.4 29808.3 29822.7 30188.8 33916.8 34087.7 34421.5 37714.6 37740.2 8738.4 8926.6 9060.0 9075.5 9140.0 9506.4 9664.3 9762.8 9878.2 9921.3 9001.8 9163.6 9235.7 9363.6 9487.6 9324.3 9381.0 9417.2 9421.8 9423.7 9365.6 9511.6 9542.0 9552.4 9585.2 8064.3 8080.2 8084.8 8202.4 8321.3 7171.9 7505.1 7641.8 7660.2 7696.4 05:35:23 INFO - PROCESS | 3450 | -------- Summary: end -------- 05:35:23 INFO - PROCESS | 3450 | 05:35:24 INFO - TEST-INFO | 3450: exit 0 05:35:24 INFO - TEST-OK | dromaeo_css | took 1118393ms 05:35:24 INFO - TEST-START | kraken 05:35:24 INFO - operating with platform_type : linux_ 05:35:24 INFO - Initialising browser for kraken test... 05:35:24 INFO - TEST-INFO | started process 3640 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxIieVd/profile http://localhost:54939/getInfo.html) 05:35:28 INFO - PROCESS | 3640 | __metrics Screen width/height:1600/1200 05:35:28 INFO - PROCESS | 3640 | colorDepth:24 05:35:28 INFO - PROCESS | 3640 | Browser inner width/height: 1024/697 05:35:28 INFO - PROCESS | 3640 | __metrics 05:35:28 INFO - PROCESS | 3640 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:35:29 INFO - PROCESS | 3640 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:35:29 ERROR - PROCESS | 3640 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 05:35:29 INFO - TEST-INFO | 3640: exit 0 05:35:29 INFO - Browser initialized. 05:35:29 INFO - Running cycle 1/1 for kraken test... 05:35:29 INFO - TEST-INFO | started process 3721 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxIieVd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:35:41 INFO - PROCESS | 3721 | RSS: Main: 150228992 05:35:41 INFO - PROCESS | 3721 | 05:35:44 INFO - PROCESS | 3721 | Cycle 1(1): loaded http://localhost:54939/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54939/tests/kraken/driver.html?testName=audio-beat-detection) 05:35:45 INFO - PROCESS | 3721 | RSS: Main: 184270848 05:35:45 INFO - PROCESS | 3721 | 05:35:47 INFO - PROCESS | 3721 | Cycle 1(1): loaded http://localhost:54939/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54939/tests/kraken/driver.html?testName=audio-dft) 05:35:48 INFO - PROCESS | 3721 | RSS: Main: 174362624 05:35:48 INFO - PROCESS | 3721 | 05:35:51 INFO - PROCESS | 3721 | Cycle 1(1): loaded http://localhost:54939/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54939/tests/kraken/driver.html?testName=audio-fft) 05:35:51 INFO - PROCESS | 3721 | RSS: Main: 161046528 05:35:51 INFO - PROCESS | 3721 | 05:35:53 INFO - PROCESS | 3721 | Cycle 1(1): loaded http://localhost:54939/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54939/tests/kraken/driver.html?testName=audio-oscillator) 05:35:54 INFO - PROCESS | 3721 | RSS: Main: 163717120 05:35:54 INFO - PROCESS | 3721 | 05:35:56 INFO - PROCESS | 3721 | Cycle 1(1): loaded http://localhost:54939/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54939/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:35:57 INFO - PROCESS | 3721 | RSS: Main: 166105088 05:35:57 INFO - PROCESS | 3721 | 05:36:00 INFO - PROCESS | 3721 | Cycle 1(1): loaded http://localhost:54939/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54939/tests/kraken/driver.html?testName=imaging-darkroom) 05:36:00 INFO - PROCESS | 3721 | RSS: Main: 165863424 05:36:00 INFO - PROCESS | 3721 | 05:36:04 INFO - PROCESS | 3721 | Cycle 1(1): loaded http://localhost:54939/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54939/tests/kraken/driver.html?testName=imaging-desaturate) 05:36:04 INFO - PROCESS | 3721 | RSS: Main: 166887424 05:36:04 INFO - PROCESS | 3721 | 05:36:07 INFO - PROCESS | 3721 | Cycle 1(1): loaded http://localhost:54939/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54939/tests/kraken/driver.html?testName=json-parse-financial) 05:36:08 INFO - PROCESS | 3721 | RSS: Main: 165343232 05:36:08 INFO - PROCESS | 3721 | 05:36:10 INFO - PROCESS | 3721 | Cycle 1(1): loaded http://localhost:54939/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54939/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:36:10 INFO - PROCESS | 3721 | RSS: Main: 176386048 05:36:10 INFO - PROCESS | 3721 | 05:36:12 INFO - PROCESS | 3721 | Cycle 1(1): loaded http://localhost:54939/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54939/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:36:13 INFO - PROCESS | 3721 | RSS: Main: 176967680 05:36:13 INFO - PROCESS | 3721 | 05:36:15 INFO - PROCESS | 3721 | Cycle 1(1): loaded http://localhost:54939/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54939/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:36:16 INFO - PROCESS | 3721 | RSS: Main: 186335232 05:36:16 INFO - PROCESS | 3721 | 05:36:18 INFO - PROCESS | 3721 | Cycle 1(1): loaded http://localhost:54939/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:36:19 INFO - PROCESS | 3721 | RSS: Main: 191811584 05:36:19 INFO - PROCESS | 3721 | 05:36:21 INFO - PROCESS | 3721 | Cycle 1(1): loaded http://localhost:54939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:36:22 INFO - PROCESS | 3721 | RSS: Main: 189370368 05:36:22 INFO - PROCESS | 3721 | 05:36:24 INFO - PROCESS | 3721 | Cycle 1(1): loaded http://localhost:54939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54939/tests/kraken/driver.html?testName=ai-astar) 05:36:24 INFO - PROCESS | 3721 | RSS: Main: 247570432 05:36:24 INFO - PROCESS | 3721 | 05:36:24 INFO - PROCESS | 3721 | __start_tp_report 05:36:24 INFO - PROCESS | 3721 | _x_x_mozilla_page_load 05:36:24 INFO - PROCESS | 3721 | _x_x_mozilla_page_load_details 05:36:24 INFO - PROCESS | 3721 | |i|pagename|runs| 05:36:24 INFO - PROCESS | 3721 | |0;ai-astar;113;114;108;112;116;114;105;114;112;103 05:36:24 INFO - PROCESS | 3721 | |1;audio-beat-detection;158;128;154;166;140;158;153;131;170;131 05:36:24 INFO - PROCESS | 3721 | |2;audio-dft;161;161;161;160;164;163;162;165;161;161 05:36:24 INFO - PROCESS | 3721 | |3;audio-fft;72;72;78;94;73;74;72;114;89;72 05:36:24 INFO - PROCESS | 3721 | |4;audio-oscillator;95;95;128;95;95;94;130;94;95;130 05:36:24 INFO - PROCESS | 3721 | |5;imaging-gaussian-blur;110;109;109;109;109;110;109;109;109;110 05:36:24 INFO - PROCESS | 3721 | |6;imaging-darkroom;146;147;147;147;146;146;147;146;147;146 05:36:24 INFO - PROCESS | 3721 | |7;imaging-desaturate;95;96;95;95;95;95;95;95;95;95 05:36:24 INFO - PROCESS | 3721 | |8;json-parse-financial;71;71;71;72;71;72;71;80;68;68 05:36:24 INFO - PROCESS | 3721 | |9;json-stringify-tinderbox;67;68;68;68;69;68;69;68;68;69 05:36:24 INFO - PROCESS | 3721 | |10;stanford-crypto-aes;85;85;84;84;84;83;84;84;85;85 05:36:24 INFO - PROCESS | 3721 | |11;stanford-crypto-ccm;120;127;120;126;128;121;128;120;120;120 05:36:24 INFO - PROCESS | 3721 | |12;stanford-crypto-pbkdf2;137;153;151;149;149;140;139;147;151;138 05:36:24 INFO - PROCESS | 3721 | |13;stanford-crypto-sha256-iterative;70;70;69;70;71;68;69;70;73;69 05:36:24 INFO - PROCESS | 3721 | __end_tp_report 05:36:24 INFO - PROCESS | 3721 | __start_cc_report 05:36:24 INFO - PROCESS | 3721 | _x_x_mozilla_cycle_collect,1007 05:36:24 INFO - PROCESS | 3721 | __end_cc_report 05:36:24 INFO - PROCESS | 3721 | __startTimestamp1450791384452__endTimestamp 05:36:24 INFO - PROCESS | 3721 | 05:36:24 INFO - PROCESS | 3721 | ------- Summary: start ------- 05:36:24 INFO - PROCESS | 3721 | Number of tests: 14 05:36:24 INFO - PROCESS | 3721 | 05:36:24 INFO - PROCESS | 3721 | [#0] ai-astar Cycles:10 Average:111.10 Median:113.50 stddev:4.31 (3.8%) stddev-sans-first:4.51 05:36:24 INFO - PROCESS | 3721 | Values: 113.0 114.0 108.0 112.0 116.0 114.0 105.0 114.0 112.0 103.0 05:36:24 INFO - PROCESS | 3721 | 05:36:24 INFO - PROCESS | 3721 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:156.00 stddev:15.29 (9.8%) stddev-sans-first:15.85 05:36:24 INFO - PROCESS | 3721 | Values: 158.0 128.0 154.0 166.0 140.0 158.0 153.0 131.0 170.0 131.0 05:36:24 INFO - PROCESS | 3721 | 05:36:24 INFO - PROCESS | 3721 | [#2] audio-dft Cycles:10 Average:161.90 Median:161.50 stddev:1.60 (1.0%) stddev-sans-first:1.66 05:36:24 INFO - PROCESS | 3721 | Values: 161.0 161.0 161.0 160.0 164.0 163.0 162.0 165.0 161.0 161.0 05:36:24 INFO - PROCESS | 3721 | 05:36:24 INFO - PROCESS | 3721 | [#3] audio-fft Cycles:10 Average:81.00 Median:73.50 stddev:14.02 (19.1%) stddev-sans-first:14.48 05:36:24 INFO - PROCESS | 3721 | Values: 72.0 72.0 78.0 94.0 73.0 74.0 72.0 114.0 89.0 72.0 05:36:24 INFO - PROCESS | 3721 | 05:36:24 INFO - PROCESS | 3721 | [#4] audio-oscillator Cycles:10 Average:105.10 Median:95.00 stddev:16.74 (17.6%) stddev-sans-first:17.35 05:36:24 INFO - PROCESS | 3721 | Values: 95.0 95.0 128.0 95.0 95.0 94.0 130.0 94.0 95.0 130.0 05:36:24 INFO - PROCESS | 3721 | 05:36:24 INFO - PROCESS | 3721 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 05:36:24 INFO - PROCESS | 3721 | Values: 110.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 110.0 05:36:24 INFO - PROCESS | 3721 | 05:36:24 INFO - PROCESS | 3721 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 05:36:24 INFO - PROCESS | 3721 | Values: 146.0 147.0 147.0 147.0 146.0 146.0 147.0 146.0 147.0 146.0 05:36:24 INFO - PROCESS | 3721 | 05:36:24 INFO - PROCESS | 3721 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:36:24 INFO - PROCESS | 3721 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 05:36:24 INFO - PROCESS | 3721 | 05:36:24 INFO - PROCESS | 3721 | [#8] json-parse-financial Cycles:10 Average:71.50 Median:71.00 stddev:3.31 (4.7%) stddev-sans-first:3.50 05:36:24 INFO - PROCESS | 3721 | Values: 71.0 71.0 71.0 72.0 71.0 72.0 71.0 80.0 68.0 68.0 05:36:24 INFO - PROCESS | 3721 | 05:36:24 INFO - PROCESS | 3721 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.50 05:36:24 INFO - PROCESS | 3721 | Values: 67.0 68.0 68.0 68.0 69.0 68.0 69.0 68.0 68.0 69.0 05:36:24 INFO - PROCESS | 3721 | 05:36:24 INFO - PROCESS | 3721 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:84.50 stddev:0.67 (0.8%) stddev-sans-first:0.67 05:36:24 INFO - PROCESS | 3721 | Values: 85.0 85.0 84.0 84.0 84.0 83.0 84.0 84.0 85.0 85.0 05:36:24 INFO - PROCESS | 3721 | 05:36:24 INFO - PROCESS | 3721 | [#11] stanford-crypto-ccm Cycles:10 Average:123.00 Median:123.50 stddev:3.71 (3.0%) stddev-sans-first:3.77 05:36:24 INFO - PROCESS | 3721 | Values: 120.0 127.0 120.0 126.0 128.0 121.0 128.0 120.0 120.0 120.0 05:36:24 INFO - PROCESS | 3721 | 05:36:24 INFO - PROCESS | 3721 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.40 Median:149.00 stddev:6.19 (4.2%) stddev-sans-first:5.77 05:36:24 INFO - PROCESS | 3721 | Values: 137.0 153.0 151.0 149.0 149.0 140.0 139.0 147.0 151.0 138.0 05:36:24 INFO - PROCESS | 3721 | 05:36:24 INFO - PROCESS | 3721 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:1.37 (2.0%) stddev-sans-first:1.45 05:36:24 INFO - PROCESS | 3721 | Values: 70.0 70.0 69.0 70.0 71.0 68.0 69.0 70.0 73.0 69.0 05:36:24 INFO - PROCESS | 3721 | -------- Summary: end -------- 05:36:24 INFO - PROCESS | 3721 | 05:36:25 INFO - TEST-INFO | 3721: exit 0 05:36:25 INFO - TEST-OK | kraken | took 60890ms 05:36:25 INFO - TEST-START | v8_7 05:36:25 INFO - operating with platform_type : linux_ 05:36:25 INFO - Initialising browser for v8_7 test... 05:36:25 INFO - TEST-INFO | started process 3968 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgwy1cI/profile http://localhost:54939/getInfo.html) 05:36:29 INFO - PROCESS | 3968 | __metrics Screen width/height:1600/1200 05:36:29 INFO - PROCESS | 3968 | colorDepth:24 05:36:29 INFO - PROCESS | 3968 | Browser inner width/height: 1024/697 05:36:29 INFO - PROCESS | 3968 | __metrics 05:36:29 INFO - PROCESS | 3968 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:36:29 INFO - PROCESS | 3968 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:36:30 INFO - TEST-INFO | 3968: exit 0 05:36:30 INFO - Browser initialized. 05:36:30 INFO - Running cycle 1/1 for v8_7 test... 05:36:30 INFO - TEST-INFO | started process 4048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgwy1cI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:36:42 INFO - PROCESS | 4048 | RSS: Main: 150466560 05:36:42 INFO - PROCESS | 4048 | 05:37:04 INFO - PROCESS | 4048 | Cycle 1(1): loaded http://localhost:54939/tests/v8_7/run.html (next: http://localhost:54939/tests/v8_7/run.html) 05:37:04 INFO - PROCESS | 4048 | RSS: Main: 454012928 05:37:04 INFO - PROCESS | 4048 | 05:37:04 INFO - PROCESS | 4048 | __start_tp_report 05:37:04 INFO - PROCESS | 4048 | _x_x_mozilla_page_load 05:37:04 INFO - PROCESS | 4048 | _x_x_mozilla_page_load_details 05:37:04 INFO - PROCESS | 4048 | |i|pagename|runs| 05:37:04 INFO - PROCESS | 4048 | |0;Richards;165.18004625041294 05:37:04 INFO - PROCESS | 4048 | |1;DeltaBlue;186.84603886397608 05:37:04 INFO - PROCESS | 4048 | |2;Encrypt;278.9400278940028 05:37:04 INFO - PROCESS | 4048 | |3;Decrypt;5208.333333333333 05:37:04 INFO - PROCESS | 4048 | |4;RayTrace;1972.3865877712033 05:37:04 INFO - PROCESS | 4048 | |5;Earley;804.5052292839904 05:37:04 INFO - PROCESS | 4048 | |6;Boyer;12219.512195121952 05:37:04 INFO - PROCESS | 4048 | |7;RegExp;27135.135135135137 05:37:04 INFO - PROCESS | 4048 | |8;Splay;592.4170616113744 05:37:04 INFO - PROCESS | 4048 | |9;NavierStokes;4830.917874396136 05:37:04 INFO - PROCESS | 4048 | __end_tp_report 05:37:04 INFO - PROCESS | 4048 | __startTimestamp1450791424548__endTimestamp 05:37:04 INFO - PROCESS | 4048 | 05:37:04 INFO - PROCESS | 4048 | ------- Summary: start ------- 05:37:04 INFO - PROCESS | 4048 | Number of tests: 10 05:37:04 INFO - PROCESS | 4048 | 05:37:04 INFO - PROCESS | 4048 | [#0] Richards Cycles:1 Average:165.18 Median:165.18 stddev:0.00 (0.0%) 05:37:04 INFO - PROCESS | 4048 | Values: 165.2 05:37:04 INFO - PROCESS | 4048 | 05:37:04 INFO - PROCESS | 4048 | [#1] DeltaBlue Cycles:1 Average:186.85 Median:186.85 stddev:0.00 (0.0%) 05:37:04 INFO - PROCESS | 4048 | Values: 186.8 05:37:04 INFO - PROCESS | 4048 | 05:37:04 INFO - PROCESS | 4048 | [#2] Encrypt Cycles:1 Average:278.94 Median:278.94 stddev:0.00 (0.0%) 05:37:04 INFO - PROCESS | 4048 | Values: 278.9 05:37:04 INFO - PROCESS | 4048 | 05:37:04 INFO - PROCESS | 4048 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 05:37:04 INFO - PROCESS | 4048 | Values: 5208.3 05:37:04 INFO - PROCESS | 4048 | 05:37:04 INFO - PROCESS | 4048 | [#4] RayTrace Cycles:1 Average:1972.39 Median:1972.39 stddev:0.00 (0.0%) 05:37:04 INFO - PROCESS | 4048 | Values: 1972.4 05:37:04 INFO - PROCESS | 4048 | 05:37:04 INFO - PROCESS | 4048 | [#5] Earley Cycles:1 Average:804.51 Median:804.51 stddev:0.00 (0.0%) 05:37:04 INFO - PROCESS | 4048 | Values: 804.5 05:37:04 INFO - PROCESS | 4048 | 05:37:04 INFO - PROCESS | 4048 | [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 05:37:04 INFO - PROCESS | 4048 | Values: 12219.5 05:37:04 INFO - PROCESS | 4048 | 05:37:04 INFO - PROCESS | 4048 | [#7] RegExp Cycles:1 Average:27135.14 Median:27135.14 stddev:0.00 (0.0%) 05:37:04 INFO - PROCESS | 4048 | Values: 27135.1 05:37:04 INFO - PROCESS | 4048 | 05:37:04 INFO - PROCESS | 4048 | [#8] Splay Cycles:1 Average:592.42 Median:592.42 stddev:0.00 (0.0%) 05:37:04 INFO - PROCESS | 4048 | Values: 592.4 05:37:04 INFO - PROCESS | 4048 | 05:37:04 INFO - PROCESS | 4048 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 05:37:04 INFO - PROCESS | 4048 | Values: 4830.9 05:37:04 INFO - PROCESS | 4048 | -------- Summary: end -------- 05:37:04 INFO - PROCESS | 4048 | 05:37:05 INFO - TEST-INFO | 4048: exit 0 05:37:05 INFO - TEST-OK | v8_7 | took 40165ms 05:37:05 INFO - SUITE-END | took 1219s 05:37:05 INFO - Completed test suite (00:20:19) 05:37:05 INFO - Working with test: dromaeo_css 05:37:05 INFO - Generating results file: dromaeo_css 05:37:05 INFO - Working with test: kraken 05:37:05 INFO - Generating results file: kraken 05:37:05 INFO - javascript benchmark 05:37:05 INFO - Working with test: v8_7 05:37:05 INFO - Generating results file: v8_7 05:37:05 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:37:05 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 05:37:05 INFO - process_Request line: dromaeo_css 6208.53 graph.html#tests=[[72,132,35]] 05:37:05 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:37:05 INFO - process_Request line: kraken 1521.20 graph.html#tests=[[232,132,35]] 05:37:05 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:37:05 INFO - process_Request line: v8_7 19792.48 graph.html#tests=[[230,132,35]] 05:37:05 INFO - RETURN: dromaeo_css: 6208.53 05:37:05 INFO - RETURN: kraken: 1521.20 05:37:05 INFO - RETURN: v8_7: 19792.48 05:37:05 INFO - javascript benchmark 05:37:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2595.0917178987356, 2646.722094180111, 2657.229403472993, 2669.6929853066904, 2688.7983401244906, 4410.338449232617, 4529.524399938008, 4570.10882877839, 4602.838900638479, 4628.976855115724, 4550.226461501545, 4566.31505274209, 4625.537446255373, 4626.144163329778, 4696.272077827934, 4294.592013758688, 4298.828046878121, 4303.935440968388, 4304.720193187449, 4351.5648435156545, 4118.073433477473, 4333.848315308965, 4349.652027837781, 4414.580614841585, 4420.226460369438, 4166.979165104155, 4243.575642435762, 4269.67977401693, 4299.72051816634, 4324.156789426063, 4340.956590434118, 4343.1747967886, 4343.869683909456, 4344.413504176959, 4388.758618275993, 4338.197433474786, 4344.022594916119, 4345.826166953318, 4366.8034938427845, 4405.11897620474, 4388.71473354231, 4420.911581768347, 4476.507584165739, 4497.168023915553, 4543.1140927519145, 4936.432310284327, 4945.258211268302, 4951.653384263103, 4952.62855285855, 4982.750862456863, 4963.032208719301, 4965.0566392385335, 4969.627277954168, 4970.353853998993, 4983.775730092155, 4541.091781643651, 4573.885652858705, 4656.068786242698, 4657.371254880582, 4693.507181745936, 5096.541311282002, 5165.173572228426, 5166.018456493254, 5183.844484665466, 5193.1171700810955, 4964.056829202512, 4981.103401387712, 4985.52637499437, 5030.572401345853, 5031.547160755549, 4719.315699223594, 4827.444843842933, 4829.517048295213, 4841.515848415201, 4943.036107958914, 4901.705897646081, 4935.876603084952, 4937.23472861707, 4947.90104197914, 4994.126027945095, 4915.631327650441, 4917.975410122926, 4927.95072049282, 4930.605551555867, 4974.204127339608, 4056.411820286042, 4117.279476091672, 4150.792460376969, 4201.117765269267, 4216.683748718859, 3683.3369993401443, 3719.628037196259, 3721.776693398405, 3742.4760533525327, 3758.7180961428003, 4324.329728892027, 4342.848000319974, 4347.7614676171825, 4348.369486424451, 4391.3412988051405, 4734.763261836894, 4807.230843065093, 4855.295982082649, 4892.902141957141, 4975.278584605212, 4270.530241673413, 4279.914401711948, 4295.785210739513, 4312.870613881589, 4327.0, 4448.755318457451, 4464.665150113755, 4471.083427897273, 4473.821047158142, 4515.435570553681, 4517.164324599959, 4621.2837010263465, 4623.583877451046, 4712.481627021093, 4747.098051370229, 4859.8299059534165, 4945.901081978413, 4946.258061290835, 4963.528464795839, 5007.524285192901, 4733.029728905635, 4742.905141897074, 4744.240921452551, 4748.0978614063215, 4777.593904518016, 4752.738599377068, 4897.020595880766, 4897.045076210247, 4921.212605983169, 4979.800807967641, 4860.0279944012045, 4917.385326834145, 4921.729304888266, 4924.630652701134, 4974.651774375759, 4813.350197723263, 4860.392450943632, 4871.585915197106, 4876.4392094909535, 4907.141250281115, 4585.679002469795, 4727.692699974491, 4731.479537250969, 4856.125897338513, 4903.95096049035, 4672.369230153886, 4728.0, 4737.857864264078, 4745.4542727585385, 4787.904241915073, 4932.284818701197, 4960.255961605788, 4963.429205641398, 4964.702117872939, 4965.826196083264, 4578.908421831611, 4659.34769132315, 4702.03608260299, 4841.163355595535, 4852.490488498657], "unit": "score", "name": "dojo.html", "value": 4557.917117407232}, {"lowerIsBetter": false, "replicates": [571.8799052199038, 571.9685417302048, 579.7130420441882, 585.9423740149032, 593.9991114971272, 24647.13735019275, 32435.83782081089, 32940.50589241163, 32962.50556241658, 33026.174345641404, 38915.41626875592, 39672.80163599178, 39752.20495590087, 39756.80121599388, 39837.0, 6877.415419689332, 6983.615901125436, 7796.649150788228, 7960.0, 7962.800929976739, 10044.146247568966, 10154.136898363611, 10224.539895704711, 10225.693229203098, 10234.283600147992, 9784.119429251366, 9889.357191782512, 9892.950535247313, 9894.109530142287, 9895.356801807895, 7084.787456376317, 7215.783526494213, 7252.637368131625, 7252.782416527512, 9759.560819763128, 10074.848877266846, 10377.688669339932, 10384.480775961172, 10394.116500097502, 10403.84394234087, 36092.45861312083, 36406.453903191476, 36423.0, 36457.270854583025, 36490.63509364899, 2814.7185281471893, 2863.3700585871075, 2868.6270784797844, 3342.715869151125, 3636.799976001319, 27106.300095146427, 27356.58965115525, 27504.724952750417, 27592.862035689694, 27822.86088569544, 3278.5737854079057, 3340.1315657929113, 3341.231516751161, 3345.2974875276223, 3467.219875527986, 209214.0, 211808.94095529578, 212215.0, 212580.0, 212592.0, 49576.50423495791, 53578.0, 53583.0, 53717.73141134269, 54035.729821350644, 43897.12205755931, 63105.0, 64822.0, 64838.35161648417, 64839.0, 13100.672483187996, 13232.867671323356, 13233.735325293634, 13236.669083272995, 13250.204987700768, 11201.0, 11277.436128193558, 11333.546658133748, 11347.546098156146, 11349.375784331776, 18265.360712375004, 18385.448436546925, 18427.63144737098, 18580.44258672242, 18603.720944185578, 7421.962890185622, 7631.809204769926, 7668.0, 7713.9200511928375, 7814.0, 802.7993001749562, 819.8893149424871, 839.6305625524872, 862.8015556422058, 904.421170450912, 24286.635700464507, 24471.265862024167, 25000.4999900001, 25243.242702718948, 25259.368515787253, 902.3548163063441, 923.9168474837297, 932.1983094538691, 989.6882482018141, 992.7319623701704, 13034.80447793284, 13054.738905221842, 13143.277119758504, 13206.867931320756, 13227.735445291233, 290670.0, 291624.0, 294350.0, 296682.0, 297363.0, 43712.0, 44360.0, 44366.77816610896, 44369.334459983125, 44392.0, 1155.0874808900874, 1157.3229660648615, 1168.9473973671375, 1180.7933611617932, 1182.9526818927147, 23757.406064848517, 25003.87498062498, 29427.057294270402, 29526.704732952396, 30791.69208307978, 41569.58430415657, 41771.7911410441, 42116.78941605272, 42120.578794211666, 42188.78905605452, 231723.0, 232808.0, 234555.0, 236645.0, 238193.0, 33365.49951750774, 35034.474482883285, 37119.07202319964, 41112.58887411088, 41510.79244603758, 35829.28341433105, 35997.1000724984, 36708.81645591755, 36734.0, 37286.0, 32228.516572251905, 32441.188970275933, 32892.83553582217, 33238.50142247917, 33324.333513330086, 28289.00377113393, 32564.51153232751, 32650.51024234591, 34087.48868766921, 38143.23713525658, 31476.0, 31827.6817231834, 31835.522467162547, 31918.840405797822, 32097.0, 27655.723442765317, 29970.14688525922, 30606.234844129074, 33404.66595334113, 35007.29985400227, 23132.884335578216, 23269.650955235345, 24062.87968560146, 24273.271801845975, 24697.0], "unit": "score", "name": "ext.html", "value": 17108.137736634253}, {"lowerIsBetter": false, "replicates": [337.5561137104707, 339.755376129187, 340.67295396419433, 341.118209428627, 341.515048630944, 12640.747185056294, 13082.280474573894, 15020.924895375521, 15091.471798487042, 15747.370105195792, 12890.935545322283, 13128.015398845077, 14524.709505809877, 14953.626159346022, 15648.295826687798, 4861.343718597988, 5024.246363045536, 5042.3949126104735, 5043.193089105744, 5047.041062198189, 3775.093977445421, 3893.4743809585766, 4959.826406075788, 5000.874978125539, 5008.073506401327, 5538.667679939196, 5674.858128546778, 5706.400827913071, 5711.143328500737, 5715.1998720179, 5537.169424586304, 5665.886682266352, 5673.971630141864, 5695.829125126212, 5702.54379649627, 5105.923411148836, 5126.820561280338, 5131.897362052775, 5136.203888397305, 5138.614603904684, 18462.815371846245, 18700.345487907995, 18899.433017009513, 18903.90548047251, 19127.80872191274, 1818.7453756474104, 1855.471190710641, 1903.961920761577, 1910.1977169588667, 2247.1573160064977, 12310.076744244217, 12477.188982716094, 12540.372981350987, 12788.209650648916, 12953.0, 1726.9913650431668, 1732.644807814395, 1739.6607661506011, 1789.150153677006, 1820.5721655410969, 51446.0, 53284.20073698936, 54403.72798135984, 55044.44955550433, 55582.16626750602, 9120.908790912139, 9216.354855160209, 9378.062193780568, 9385.155336019654, 9423.48170850596, 12016.218945768496, 12020.218685785396, 12047.096467764954, 12054.276743395425, 12076.154669173073, 7147.678354474061, 7218.0, 7220.638968051577, 7249.565026098451, 7353.522021068614, 7145.642717864086, 7147.857042859114, 7159.498835081495, 7237.167725711611, 7244.818879528054, 5672.404397538282, 5693.658380497183, 5699.914501282484, 5726.284214473191, 5726.828195154152, 1516.4616561120863, 1580.4310448238625, 1633.55893908644, 1654.1067823375483, 1665.8001039875292, 834.1283358889974, 853.125546315032, 856.3791251342726, 901.3735453859505, 945.5272363818091, 14858.851411485746, 15588.220588970506, 15629.921850390903, 16032.679346413239, 16269.267882945296, 758.7192738686721, 838.9244967952792, 888.7911340834899, 924.6763632728625, 947.313197931508, 8221.342292616577, 8612.009618893908, 8802.735917922344, 9553.140217380469, 9591.856122158173, 448636.0, 450228.0, 453218.0, 475449.0, 480550.0, 64588.0, 69647.65176174087, 69702.30297696959, 69924.6503767488, 69931.65034174899, 1036.8341065429495, 1056.2975621211808, 1056.3186744549723, 1068.326954018963, 1091.0998426298336, 14840.257987100818, 14843.109413435228, 14971.700565988836, 15029.849701502844, 15169.469068582988, 32360.83819580887, 33310.333793323516, 33553.83223083869, 33573.32853342968, 33952.320953580296, 41669.0, 43424.56575434205, 44163.77918110389, 45085.32372014357, 46985.76507117443, 8422.368322375723, 8886.600102995251, 9002.0, 9007.774805629911, 9107.544622768703, 10312.845307320245, 10319.587216511256, 10410.0, 10420.218483613608, 10484.056434920894, 12575.182613130117, 13183.868161318263, 13455.596332110052, 13567.796483052565, 13607.931960340135, 12077.939610301892, 12465.314407707663, 12543.310117943236, 12725.61823145307, 12746.171498852545, 10747.946260268649, 13233.602991910258, 13296.534621288209, 13794.517191898236, 13834.792478112635, 8784.868226976472, 8833.33749968742, 8838.867416988622, 8887.0, 8910.618854077627, 13640.590782276548, 13814.447422103003, 14012.299385030503, 14176.291185440892, 14335.85664143387], "unit": "score", "name": "jquery.html", "value": 8297.020815362395}, {"lowerIsBetter": false, "replicates": [1323.477226495535, 1543.621812655899, 1665.7085010123226, 1685.2079522624363, 1722.3024675006618, 5717.571182161339, 6673.9666301668485, 6803.353681400259, 6819.693113809878, 6824.215215250248, 6845.247022827485, 7004.0, 7007.474439417038, 7008.159020917497, 7019.087518622585, 2029.4419034765483, 2070.3581889614193, 2070.554830711397, 2073.460900165953, 2074.4917495213695, 2041.591681663666, 2043.407411850569, 2054.856160068796, 2065.452655046414, 2067.4417907165057, 1962.4995626115392, 1986.6026794641057, 2011.4468521156653, 2015.7278767366438, 2016.67733162694, 2027.4627223785708, 2049.600327936053, 2056.393363957636, 2057.5473395852887, 2058.5265388960547, 2018.1826360323946, 2054.8253398460997, 2054.8253398461147, 2057.897105144737, 2059.124871929439, 6861.622610756406, 6935.653217339112, 6936.4797640176685, 6940.479464040217, 6946.444284457231, 4006.8380169750735, 4063.9593604063875, 4076.735012224196, 4091.488563929509, 4101.364288535282, 2557.309526427854, 2604.0, 2611.973880261211, 2612.542805009116, 2635.3279913622096, 873.6461732998082, 879.8284334554764, 887.3389324952951, 898.8876390451194, 908.895477020138, 9343.953280233556, 9366.063393660648, 9370.765730856714, 9382.202512786422, 9390.5304734763, 3662.468942003448, 3670.6785557199387, 3740.2519496100344, 3743.5320584926885, 3745.4007358823, 7992.640331185111, 8004.119546849842, 8012.1186669466315, 8014.078380986261, 8017.4387792855105, 4141.875743727693, 4161.10536234711, 4169.395437661583, 4171.207470580641, 4186.623203911662, 3226.596675415573, 3318.5685860837934, 3601.9279614408088, 3772.0946972726897, 3794.772313661189, 3223.3553289341758, 3248.3503299340227, 3276.3938671345877, 3300.6369299377047, 3319.55186049885, 1005.5123265216364, 1007.596961215505, 1014.0467960117466, 1015.0, 1016.8576399304103, 1122.7978963786434, 1146.266389510714, 1152.4986630815622, 1152.608113241502, 1161.5063597970998, 6441.806745797634, 6495.512836537184, 6512.0, 6520.282768895418, 6528.738850445929, 398.9740666856645, 406.28899426004494, 406.8392984770999, 407.1084325327523, 407.1307757936767, 5190.2214667800135, 5221.295125158131, 5239.44985776488, 5239.44985776488, 5243.134882744381, 8205.179482051746, 8239.876401853977, 8245.917540824636, 8358.289545388589, 8415.779711941734, 8205.835883282301, 8251.257386835214, 8255.587220638945, 8293.087760346478, 8355.289800366916, 6464.127342808661, 6575.914974029231, 6617.205935287796, 6633.369829866155, 6641.601503909781, 6330.303666596763, 6351.777687780906, 6355.841103972438, 6357.205349331333, 6360.4911607072245, 6935.653217339213, 7276.890846637199, 7422.740204092831, 7477.4391920605085, 7494.6252687366505, 7364.742234021784, 7566.1298950621385, 7577.659005344663, 7735.381169506313, 7849.568273744999, 5169.095408303607, 5416.350037995308, 6200.689965501617, 6268.4671802897265, 6278.497720182466, 6319.873602528016, 6454.5159113065765, 6463.64449955257, 6478.222613286436, 6486.383793539606, 5890.764369425175, 5952.166696662384, 6012.338642749207, 6087.147799308189, 6116.66358350295, 6022.728977196124, 6119.479844213113, 6163.229596300463, 6170.969145154246, 6220.253569571681, 5915.763369465345, 6050.21347224858, 6053.939460605337, 6069.0289553672965, 6101.420365065312, 5873.970630146822, 5931.822045338647, 5936.13925980739, 5937.317208521075, 5939.3466718661775, 5902.5277977762535, 5983.922893879144, 6066.181065556093, 6086.634801911722, 6110.969445152746], "unit": "score", "name": "mootools.html", "value": 3891.67415647596}, {"lowerIsBetter": false, "replicates": [296.71218917649884, 296.8960863697707, 301.83097465419365, 302.15848860922324, 305.0588933141259, 5244.606654500918, 5309.469053094688, 5353.0096932067545, 5404.000259951912, 5413.810516631918, 5230.476952304777, 5293.682379057259, 5294.52349288564, 5299.894002119955, 5302.893942121155, 3935.7638541687447, 4152.2941100012995, 4165.83336666533, 4170.9582904170875, 4174.958250417502, 3950.7036972227197, 4027.597240275978, 4076.694247931402, 4077.87766367008, 4089.9182016359805, 4008.6592639625665, 4020.095478517325, 4025.2754504189234, 4035.829609413281, 4042.73722208057, 3782.413725872494, 3857.189990102082, 3932.7640341579313, 4015.0765323975647, 4019.718619696622, 3561.465780132975, 3570.5715314162467, 3571.928561428757, 3572.732045096602, 3575.606683264865, 5057.367829021372, 5057.519535644108, 5076.238564215398, 5078.0, 5080.593552515827, 4672.415948006499, 4675.649326300541, 4683.953160468386, 4685.688007357945, 4686.0, 5400.297961265011, 5546.362168350651, 5573.888522229533, 5577.330720313588, 5615.747291371898, 3853.537575490931, 3854.4025676019983, 3856.749311294757, 3861.2470568239205, 3861.7876016819064, 5841.065429531254, 5926.081457374071, 5926.940730592682, 5927.555433342516, 5933.821985340403, 3996.2407142642805, 3999.92000160001, 4001.8199181036925, 4005.1989602079702, 4022.1754540319166, 3886.0, 4055.0, 4055.7160998730396, 4064.4919385076864, 4069.0, 4663.533646635309, 4674.158651442773, 4678.064387122589, 4678.415198100238, 4678.578927896438, 5605.271314729141, 5607.467290607386, 5609.943900561024, 5614.157876318503, 5615.129654903415, 1410.0975375759522, 1430.7853821926794, 1431.0912570517587, 1431.3487363249697, 1432.44134787433, 949.7910459698855, 953.1136043479491, 955.4362925873768, 975.7170420578095, 980.8087422952456, 4921.0, 4928.926066109011, 4930.876728081755, 4934.629902757308, 4937.432195297515, 5772.826815195551, 5776.971115144482, 5778.855528611818, 5782.653040817564, 5782.797602083907, 4928.457869634337, 4930.11257973561, 4930.6795058321095, 4936.259561065797, 4941.061198372297, 3055.0682041976966, 3099.3336432666633, 3133.263683034485, 3135.059482155344, 3138.340948400861, 5542.0, 5586.804461843816, 5594.776208951596, 5597.384287728347, 5600.607957443021, 5981.132735753292, 5983.401659833982, 5995.100734889801, 6056.970315046365, 6070.119832624245, 5506.256655351556, 5508.91736623951, 5534.335879694462, 5556.805511807067, 5568.081266591048, 5668.801591944262, 5834.474897259267, 5839.153322768259, 5839.357670656309, 5843.2695913010875, 5720.914186287126, 5724.398938111438, 5725.112607545837, 5736.225609542826, 5744.626599271034, 5538.501534861882, 5540.196671482532, 5543.972280138573, 5547.639403438763, 5547.805826796042, 3827.9234415312094, 3871.380579107329, 3899.5515515716056, 3922.941155882607, 3924.6860251179264, 5857.619254748598, 5864.149698293638, 5865.384134665969, 5866.67733274674, 5871.2073870027, 5605.32736071674, 5652.293463317085, 5654.802081927277, 5656.095024796013, 5658.660480371191, 5602.971985140048, 5610.410906854721, 5613.691246981455, 5619.044762390322, 5620.522255608155, 5306.071437498499, 5440.238366628596, 5442.510174084351, 5467.097928841697, 5484.972575137099, 5374.0864053111845, 5504.53211477029, 5628.493435590816, 5645.266115404971, 5661.377248502579, 5367.758450869798, 5424.674519528841, 5425.620206585501, 5430.348358197041, 5439.891202176013], "unit": "score", "name": "prototype.html", "value": 4188.326954016986}, {"lowerIsBetter": false, "replicates": [678.4572342126298, 735.9080114985624, 770.7918861907282, 773.9729109481168, 799.6121880887769, 11154.10767138629, 11345.319280843156, 11402.828957565644, 11416.942915285432, 11426.257293275941, 10462.42456664885, 10963.56145754171, 10982.835257471124, 11010.559577616907, 11017.0, 612.8130920069377, 778.0274656679151, 791.5685951156634, 792.1049214387763, 792.2552800367636, 774.8605251054807, 789.826238227589, 792.7819849541364, 792.7978365516785, 793.2226418110256, 640.9839754006141, 647.4949539359308, 814.4380377539479, 825.4923222218323, 834.3867257565685, 819.0785366462729, 819.9508029518219, 820.9876851847227, 821.1747194069981, 821.4906757810136, 607.4350853706052, 608.191105829246, 608.4493533352323, 608.580079744979, 608.6713174885557, 11515.654530364103, 11547.884521154765, 11602.477888495037, 11610.129240307011, 11614.245074070159, 10779.137668986541, 11029.227954043221, 11082.168837337233, 11214.10287177024, 11540.596079137275, 8951.507667078307, 8975.775605609846, 9284.907150928471, 9289.907100928971, 9290.0, 3231.757618178646, 3315.900522984314, 3319.369319829225, 3322.1196382958537, 3386.204242003152, 36408.992516234786, 36533.45199822005, 36749.44875826865, 36877.26245475102, 37082.07294817624, 9050.502222377701, 9160.541972901328, 9226.49254291007, 9307.90692093084, 9475.526223688788, 16127.516174514783, 16130.435434759727, 16208.270627821776, 16208.918955405148, 16210.270537825827, 6249.593776404519, 6327.240731112204, 6446.7421303148285, 6573.342665733484, 6788.558743681645, 3635.4546817976984, 3693.575238847513, 3699.6855267302044, 3707.88876333705, 3710.2023065040607, 2576.291519832061, 2594.9351266218496, 2605.71337152913, 2611.229687242268, 2612.6342312076326, 478.5477723551211, 495.44757595281004, 501.7516329416962, 507.0366304022387, 512.8358925143992, 505.8381317978285, 565.3046752494373, 579.4900487570994, 580.6167929166729, 589.4576989169974, 7208.675609597581, 7394.55632662042, 7552.811179720551, 7555.244475552401, 7571.3942884569105, 541.8374487653688, 576.7577617400701, 581.6306645280278, 605.7032054293364, 619.3434958943534, 3321.335732853439, 3508.333416650828, 3509.298140371936, 3616.5840928293055, 3630.618785027587, 44358.0, 45536.0, 45700.08599827985, 45700.771496142304, 45845.31232031522, 40320.39519407211, 41621.79189104035, 41757.37363939543, 41757.791211043754, 41926.79036604797, 36527.26945461076, 37037.44443833291, 37435.62564374322, 37520.0, 37656.0, 7018.684159212949, 7033.0, 7074.964625176841, 7153.105861767279, 7293.671784769805, 29369.7063029367, 29670.406591868472, 29808.254793630334, 29822.701772982862, 30188.84905575458, 33916.83041584776, 34087.65912340845, 34421.48367774535, 37714.622853772205, 37740.2451950965, 8738.388312818295, 8926.553672316488, 9059.954700226457, 9075.455472671661, 9139.954300228723, 9506.429614223169, 9664.323497355117, 9762.804743905224, 9878.179417553183, 9921.305508614329, 9001.819963600823, 9163.633454661738, 9235.676751313671, 9363.625454981724, 9487.620495180116, 9324.347295689236, 9380.953095234754, 9417.152456278967, 9421.81156376855, 9423.717288481357, 9365.625374984924, 9511.619535218513, 9541.952290238505, 9552.42685438876, 9585.185259253041, 8064.274215320649, 8080.232377924088, 8084.838303233785, 8202.384821138558, 8321.251087402163, 7171.8565628688175, 7505.099388073248, 7641.808954776175, 7660.233976602295, 7696.422768292512], "unit": "score", "name": "yui.html", "value": 5430.189119558826}], "name": "dromaeo_css", "value": 6208.528081344193}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 114.0, 108.0, 112.0, 116.0, 114.0, 105.0, 114.0, 112.0, 103.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [158.0, 128.0, 154.0, 166.0, 140.0, 158.0, 153.0, 131.0, 170.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 148.9}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 160.0, 164.0, 163.0, 162.0, 165.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.9}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 78.0, 94.0, 73.0, 74.0, 72.0, 114.0, 89.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 128.0, 95.0, 95.0, 94.0, 130.0, 94.0, 95.0, 130.0], "unit": "score", "name": "audio-oscillator", "value": 105.1}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 71.0, 72.0, 71.0, 72.0, 71.0, 80.0, 68.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 71.5}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 69.0, 68.0, 69.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 84.0, 84.0, 84.0, 83.0, 84.0, 84.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.3}, {"lowerIsBetter": true, "replicates": [120.0, 127.0, 120.0, 126.0, 128.0, 121.0, 128.0, 120.0, 120.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.0}, {"lowerIsBetter": true, "replicates": [137.0, 153.0, 151.0, 149.0, 149.0, 140.0, 139.0, 147.0, 151.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.4}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 69.0, 70.0, 71.0, 68.0, 69.0, 70.0, 73.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.9}], "name": "kraken", "value": 1521.2000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.18004625041294], "unit": "score", "name": "Richards", "value": 213.71830799999998}, {"lowerIsBetter": false, "replicates": [186.84603886397608], "unit": "score", "name": "DeltaBlue", "value": 353.8635360000001}, {"lowerIsBetter": false, "replicates": [278.9400278940028], "unit": "score", "name": "Encrypt", "value": 954.2588850000001}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1972.3865877712033], "unit": "score", "name": "RayTrace", "value": 375.1744229999998}, {"lowerIsBetter": false, "replicates": [804.5052292839904], "unit": "score", "name": "Earley", "value": 828.4135089999997}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [27135.135135135137], "unit": "score", "name": "RegExp", "value": 33.572156374501965}, {"lowerIsBetter": false, "replicates": [592.4170616113744], "unit": "score", "name": "Splay", "value": 137.55680799999996}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19792.47752815674}]} 05:37:05 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19792.48"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1521.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6208.53"}}} 05:37:05 INFO - Return code: 0 05:37:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:37:05 ERROR - # TBPL SUCCESS # 05:37:05 INFO - Running post-action listener: _resource_record_post_action 05:37:05 INFO - Running post-run listener: _resource_record_post_run 05:37:06 INFO - Total resource usage - Wall time: 1237s; CPU: 13.0%; Read bytes: 10477568; Write bytes: 444878848; Read time: 4176; Write time: 346456 05:37:06 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 962560; Read time: 0; Write time: 132 05:37:06 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 8740864; Write bytes: 440389632; Read time: 4140; Write time: 345956 05:37:06 INFO - Running post-run listener: _upload_blobber_files 05:37:06 INFO - Blob upload gear active. 05:37:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:37:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:37:06 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'] 05:37:06 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 05:37:07 INFO - (blobuploader) - INFO - Open directory for files ... 05:37:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:37:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:37:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:08 INFO - (blobuploader) - INFO - Done attempting. 05:37:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:37:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:37:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:09 INFO - (blobuploader) - INFO - Done attempting. 05:37:09 INFO - (blobuploader) - INFO - Iteration through files over. 05:37:09 INFO - Return code: 0 05:37:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:37:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:37:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d36777e6aa68f3e4967efae85825678f011266bb223db560bb88e0c8c4ccc56d2d242c0360dc8eee7078701871201cef84dd8134d0d6c7399aee66ea34e64b38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/677190cb48ddf70a05751a42dc9df0e5f2cb9c64f2a6811c3c54c8e4cdb74fe6f9316415f750b9635ee82f27484f5e70f91ee56d74c1da1b7f1b01ce9bb6da61"} 05:37:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:37:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:37:09 INFO - Contents: 05:37:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d36777e6aa68f3e4967efae85825678f011266bb223db560bb88e0c8c4ccc56d2d242c0360dc8eee7078701871201cef84dd8134d0d6c7399aee66ea34e64b38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/677190cb48ddf70a05751a42dc9df0e5f2cb9c64f2a6811c3c54c8e4cdb74fe6f9316415f750b9635ee82f27484f5e70f91ee56d74c1da1b7f1b01ce9bb6da61"} 05:37:09 INFO - Copying logs to upload dir... 05:37:09 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1280.886975 ========= master_lag: -0.27 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-22 05:37:09.012969) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 05:37:09.016486) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450790145.943476-374002784 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/d36777e6aa68f3e4967efae85825678f011266bb223db560bb88e0c8c4ccc56d2d242c0360dc8eee7078701871201cef84dd8134d0d6c7399aee66ea34e64b38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/677190cb48ddf70a05751a42dc9df0e5f2cb9c64f2a6811c3c54c8e4cdb74fe6f9316415f750b9635ee82f27484f5e70f91ee56d74c1da1b7f1b01ce9bb6da61"} build_url:https://queue.taskcluster.net/v1/task/aWnEqmWcTTSAZB8hl6GKTw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011310 build_url: 'https://queue.taskcluster.net/v1/task/aWnEqmWcTTSAZB8hl6GKTw/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/d36777e6aa68f3e4967efae85825678f011266bb223db560bb88e0c8c4ccc56d2d242c0360dc8eee7078701871201cef84dd8134d0d6c7399aee66ea34e64b38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/677190cb48ddf70a05751a42dc9df0e5f2cb9c64f2a6811c3c54c8e4cdb74fe6f9316415f750b9635ee82f27484f5e70f91ee56d74c1da1b7f1b01ce9bb6da61"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 05:37:09.041463) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 05:37:09.041803) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450790145.943476-374002784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004394 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 05:37:09.126959) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 05:37:09.127283) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 05:37:09.127592) ========= ========= Total master_lag: -0.08 =========