builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-053 starttime: 1452674069.05 results: success (0) buildid: 20160112235630 builduid: c1855f8490194788a1e205d839f8856d revision: a87a27864bb88946c005815272f225cb722f83e4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 00:34:29.050869) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 00:34:29.051686) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 00:34:29.052617) ========= 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=920470bf432669ad7e3a5387000001ca-1452668763.40087-751281491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006401 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 00:34:29.098720) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 00:34:29.099222) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 00:34:29.182167) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 00:34:29.182659) ========= 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=920470bf432669ad7e3a5387000001ca-1452668763.40087-751281491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004640 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 00:34:29.237524) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 00:34:29.237838) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 00:34:29.238217) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 00:34:29.238497) ========= 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=920470bf432669ad7e3a5387000001ca-1452668763.40087-751281491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-13 00:34:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 15.3M=0.001s 2016-01-13 00:34:30 (15.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175279 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 00:34:29.425834) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 00:34:29.426166) ========= 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=920470bf432669ad7e3a5387000001ca-1452668763.40087-751281491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019690 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 00:34:29.476013) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 00:34:29.476348) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a87a27864bb88946c005815272f225cb722f83e4 --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 a87a27864bb88946c005815272f225cb722f83e4 --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=920470bf432669ad7e3a5387000001ca-1452668763.40087-751281491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-13 00:34:30,304 truncating revision to first 12 chars 2016-01-13 00:34:30,304 Setting DEBUG logging. 2016-01-13 00:34:30,304 attempt 1/10 2016-01-13 00:34:30,304 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a87a27864bb8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-13 00:34:30,586 unpacking tar archive at: fx-team-a87a27864bb8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.594017 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 00:34:30.080030) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 00:34:30.080313) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 00:34:30.095251) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 00:34:30.095509) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 00:34:30.095976) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-01-13 00:34:30.096275) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1452668763.40087-751281491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:34:31 INFO - MultiFileLogger online at 20160113 00:34:31 in /builds/slave/test 00:34:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 00:34:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:34:31 INFO - {'append_to_log': False, 00:34:31 INFO - 'base_work_dir': '/builds/slave/test', 00:34:31 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 00:34:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:34:31 INFO - 'branch': 'Fx-Team-Non-PGO', 00:34:31 INFO - 'buildbot_json_path': 'buildprops.json', 00:34:31 INFO - 'config_files': ('talos/linux_config.py',), 00:34:31 INFO - 'default_actions': ('clobber', 00:34:31 INFO - 'read-buildbot-config', 00:34:31 INFO - 'download-and-extract', 00:34:31 INFO - 'populate-webroot', 00:34:31 INFO - 'create-virtualenv', 00:34:31 INFO - 'install', 00:34:31 INFO - 'run-tests'), 00:34:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:34:31 INFO - 'download_minidump_stackwalk': True, 00:34:31 INFO - 'download_symbols': 'ondemand', 00:34:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:34:31 INFO - 'tooltool.py': '/tools/tooltool.py', 00:34:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:34:31 INFO - '/tools/misc-python/virtualenv.py')}, 00:34:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:34:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:34:31 INFO - 'installer_path': 'installer.exe', 00:34:31 INFO - 'log_level': 'info', 00:34:31 INFO - 'log_name': 'talos', 00:34:31 INFO - 'log_to_console': True, 00:34:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:34:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:34:31 INFO - 'opt_config_files': (), 00:34:31 INFO - 'pip_index': False, 00:34:31 INFO - 'sps_profile': False, 00:34:31 INFO - 'sps_profile_interval': 0, 00:34:31 INFO - 'suite': 'dromaeojs-e10s', 00:34:31 INFO - 'system_bits': '32', 00:34:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:34:31 INFO - 'title': 'talos-linux64-ix-053', 00:34:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:34:31 INFO - 'use_talos_json': True, 00:34:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:34:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:34:31 INFO - 'work_dir': 'build'} 00:34:31 INFO - ##### 00:34:31 INFO - ##### Running clobber step. 00:34:31 INFO - ##### 00:34:31 INFO - Running pre-action listener: _resource_record_pre_action 00:34:31 INFO - Running main action method: clobber 00:34:31 INFO - rmtree: /builds/slave/test/build 00:34:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:34:31 INFO - Running post-action listener: _resource_record_post_action 00:34:31 INFO - ##### 00:34:31 INFO - ##### Running read-buildbot-config step. 00:34:31 INFO - ##### 00:34:31 INFO - Running pre-action listener: _resource_record_pre_action 00:34:31 INFO - Running main action method: read_buildbot_config 00:34:31 INFO - Using buildbot properties: 00:34:31 INFO - { 00:34:31 INFO - "project": "", 00:34:31 INFO - "product": "firefox", 00:34:31 INFO - "script_repo_revision": "production", 00:34:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 00:34:31 INFO - "repository": "", 00:34:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 00:34:31 INFO - "buildid": "20160112235630", 00:34:31 INFO - "pgo_build": "False", 00:34:31 INFO - "basedir": "/builds/slave/test", 00:34:31 INFO - "buildnumber": 679, 00:34:31 INFO - "slavename": "talos-linux64-ix-053", 00:34:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:34:31 INFO - "platform": "ubuntu64_hw", 00:34:31 INFO - "scheduler": "tests-fx-team-linux64-talos", 00:34:31 INFO - "branch": "fx-team", 00:34:31 INFO - "repo_path": "integration/fx-team", 00:34:31 INFO - "revision": "a87a27864bb88946c005815272f225cb722f83e4", 00:34:31 INFO - "stage_platform": "linux64", 00:34:31 INFO - "builduid": "c1855f8490194788a1e205d839f8856d", 00:34:31 INFO - "slavebuilddir": "test" 00:34:31 INFO - } 00:34:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/apvA7PSFTCWjUAtS8fuDTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 00:34:31 INFO - Running post-action listener: _resource_record_post_action 00:34:31 INFO - ##### 00:34:31 INFO - ##### Running download-and-extract step. 00:34:31 INFO - ##### 00:34:31 INFO - Running pre-action listener: _resource_record_pre_action 00:34:31 INFO - Running main action method: download_and_extract 00:34:31 INFO - mkdir: /builds/slave/test/build/tests 00:34:31 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')]} 00:34:31 INFO - https://queue.taskcluster.net/v1/task/apvA7PSFTCWjUAtS8fuDTQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:34:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apvA7PSFTCWjUAtS8fuDTQ/artifacts/public/build/test_packages.json 00:34:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apvA7PSFTCWjUAtS8fuDTQ/artifacts/public/build/test_packages.json 00:34:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apvA7PSFTCWjUAtS8fuDTQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 00:34:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apvA7PSFTCWjUAtS8fuDTQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 00:34:35 INFO - Downloaded 1302 bytes. 00:34:35 INFO - Reading from file /builds/slave/test/build/test_packages.json 00:34:35 INFO - Using the following test package requirements: 00:34:35 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:34:35 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:34:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:34:35 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:34:35 INFO - u'jsshell-linux-x86_64.zip'], 00:34:35 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:34:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:34:35 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:34:35 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:34:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:34:35 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:34:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:34:35 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:34:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:34:35 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:34:35 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:34:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:34:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:34:35 INFO - https://queue.taskcluster.net/v1/task/apvA7PSFTCWjUAtS8fuDTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:34:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apvA7PSFTCWjUAtS8fuDTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:34:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apvA7PSFTCWjUAtS8fuDTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:34:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apvA7PSFTCWjUAtS8fuDTQ/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 00:34:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apvA7PSFTCWjUAtS8fuDTQ/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 00:34:41 INFO - Downloaded 22758864 bytes. 00:34:41 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 00:34:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:34:41 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 00:34:42 INFO - Return code: 0 00:34:42 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 00:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:34:42 INFO - https://queue.taskcluster.net/v1/task/apvA7PSFTCWjUAtS8fuDTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:34:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apvA7PSFTCWjUAtS8fuDTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:34:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apvA7PSFTCWjUAtS8fuDTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:34:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apvA7PSFTCWjUAtS8fuDTQ/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 00:34:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apvA7PSFTCWjUAtS8fuDTQ/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 00:34:45 INFO - Downloaded 22758864 bytes. 00:34:45 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 00:34:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:34:45 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 00:34:46 INFO - Return code: 0 00:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:34:46 INFO - https://queue.taskcluster.net/v1/task/apvA7PSFTCWjUAtS8fuDTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:34:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apvA7PSFTCWjUAtS8fuDTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:34:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apvA7PSFTCWjUAtS8fuDTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:34:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apvA7PSFTCWjUAtS8fuDTQ/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 00:34:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apvA7PSFTCWjUAtS8fuDTQ/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 00:34:48 INFO - Downloaded 11132285 bytes. 00:34:48 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 00:34:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:34:48 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 00:34:49 INFO - Return code: 0 00:34: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')]} 00:34:49 INFO - https://queue.taskcluster.net/v1/task/apvA7PSFTCWjUAtS8fuDTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:34:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apvA7PSFTCWjUAtS8fuDTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:34:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apvA7PSFTCWjUAtS8fuDTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:34:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apvA7PSFTCWjUAtS8fuDTQ/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 00:34:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apvA7PSFTCWjUAtS8fuDTQ/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 00:34:51 INFO - Downloaded 53853543 bytes. 00:34:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/apvA7PSFTCWjUAtS8fuDTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:34:51 INFO - mkdir: /builds/slave/test/properties 00:34:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:34:51 INFO - Writing to file /builds/slave/test/properties/build_url 00:34:51 INFO - Contents: 00:34:51 INFO - build_url:https://queue.taskcluster.net/v1/task/apvA7PSFTCWjUAtS8fuDTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:34:51 INFO - Running post-action listener: _resource_record_post_action 00:34:51 INFO - Running post-action listener: set_extra_try_arguments 00:34:51 INFO - ##### 00:34:51 INFO - ##### Running populate-webroot step. 00:34:51 INFO - ##### 00:34:51 INFO - Running pre-action listener: _resource_record_pre_action 00:34:51 INFO - Running main action method: populate_webroot 00:34:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:34:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:34:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:34:51 INFO - '--tppagecycles', 00:34:51 INFO - '7'], 00:34:51 INFO - 'tests': ['tsvgm']}}, 00:34:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:34:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:34:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:34:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:34:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:34:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:34:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:34:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:34:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:34:51 INFO - 'talos_options': ['--e10s'], 00:34:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:34:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:34:51 INFO - 'tests': ['damp', 'tps']}, 00:34:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:34:51 INFO - 'talos_options': ['--e10s'], 00:34:51 INFO - 'tests': ['damp', 'tps']}, 00:34:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:34:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:34:51 INFO - 'other': {'tests': ['a11yr', 00:34:51 INFO - 'ts_paint', 00:34:51 INFO - 'tpaint', 00:34:51 INFO - 'sessionrestore', 00:34:51 INFO - 'sessionrestore_no_auto_restore']}, 00:34:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:34:51 INFO - 'tests': ['a11yr', 00:34:51 INFO - 'ts_paint', 00:34:51 INFO - 'tpaint', 00:34:51 INFO - 'sessionrestore', 00:34:51 INFO - 'sessionrestore_no_auto_restore']}, 00:34:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:34:51 INFO - 'tests': ['a11yr', 00:34:51 INFO - 'ts_paint', 00:34:51 INFO - 'tpaint', 00:34:51 INFO - 'sessionrestore', 00:34:51 INFO - 'sessionrestore_no_auto_restore']}, 00:34:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:34:51 INFO - 'tests': ['a11yr', 00:34:51 INFO - 'ts_paint', 00:34:51 INFO - 'tpaint', 00:34:51 INFO - 'sessionrestore', 00:34:51 INFO - 'sessionrestore_no_auto_restore']}, 00:34:51 INFO - 'other_l64': {'tests': ['a11yr', 00:34:51 INFO - 'ts_paint', 00:34:51 INFO - 'tpaint', 00:34:51 INFO - 'sessionrestore', 00:34:51 INFO - 'sessionrestore_no_auto_restore']}, 00:34:51 INFO - 'other_nol64': {'tests': ['a11yr', 00:34:51 INFO - 'ts_paint', 00:34:51 INFO - 'tpaint', 00:34:51 INFO - 'sessionrestore', 00:34:51 INFO - 'sessionrestore_no_auto_restore']}, 00:34:51 INFO - 'svgr': {'tests': ['tsvgx', 00:34:51 INFO - 'tsvgr_opacity', 00:34:51 INFO - 'tart', 00:34:51 INFO - 'tscrollx', 00:34:51 INFO - 'cart']}, 00:34:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:34:51 INFO - 'tests': ['tsvgx', 00:34:51 INFO - 'tsvgr_opacity', 00:34:51 INFO - 'tart', 00:34:51 INFO - 'tscrollx', 00:34:51 INFO - 'cart']}, 00:34:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:34:51 INFO - 'tests': ['tp5o']}, 00:34:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:34:51 INFO - 'talos_options': ['--e10s'], 00:34:51 INFO - 'tests': ['tp5o']}, 00:34:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:34:51 INFO - 'talos_options': ['--xperf_path', 00:34:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:34:51 INFO - 'tests': ['tp5n']}, 00:34:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:34:51 INFO - 'talos_options': ['--e10s', 00:34:51 INFO - '--xperf_path', 00:34:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:34:51 INFO - 'tests': ['tp5n']}}, 00:34:51 INFO - 'talos.zip': {'path': '', 00:34:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:34:51 INFO - Running post-action listener: _resource_record_post_action 00:34:51 INFO - ##### 00:34:51 INFO - ##### Running create-virtualenv step. 00:34:51 INFO - ##### 00:34:51 INFO - Running pre-action listener: _resource_record_pre_action 00:34:51 INFO - Running main action method: create_virtualenv 00:34:51 INFO - Creating virtualenv /builds/slave/test/build/venv 00:34:51 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 00:34:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:34:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:34:51 INFO - Using real prefix '/usr' 00:34:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:34:52 INFO - Installing distribute.............................................................................................................................................................................................done. 00:34:54 INFO - Installing pip.................done. 00:34:54 INFO - Return code: 0 00:34:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:34:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:34:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:34:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34:54 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 0x7fa7bf072f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeae3d0>, '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 0xe19ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1a360>, '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': '920470bf432669ad7e3a5387000001ca-1452668763.40087-751281491', '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 00:34:54 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 00:34:54 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 00:34:54 INFO - Using env: {'DISPLAY': ':0', 00:34:54 INFO - 'HOME': '/home/cltbld', 00:34:54 INFO - 'LANG': 'en_US.UTF-8', 00:34:54 INFO - 'LANGUAGE': 'en_US:en', 00:34:54 INFO - 'LOGNAME': 'cltbld', 00:34:54 INFO - 'MAIL': '/var/mail/cltbld', 00:34:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:34:54 INFO - 'MOZ_NO_REMOTE': '1', 00:34:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:34:54 INFO - 'NO_EM_RESTART': '1', 00:34:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:34:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:34:54 INFO - 'PWD': '/builds/slave/test', 00:34:54 INFO - 'SHELL': '/bin/bash', 00:34:54 INFO - 'SHLVL': '1', 00:34:54 INFO - 'TERM': 'linux', 00:34:54 INFO - 'TMOUT': '86400', 00:34:54 INFO - 'USER': 'cltbld', 00:34:54 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1452668763.40087-751281491', 00:34:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:34:54 INFO - '_': '/tools/buildbot/bin/python'} 00:34:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:34:54 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 00:34:54 INFO - Cleaning up... 00:34:54 INFO - Return code: 0 00:34:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:34:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:34:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:34:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34:54 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 0x7fa7bf072f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeae3d0>, '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 0xe19ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1a360>, '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': '920470bf432669ad7e3a5387000001ca-1452668763.40087-751281491', '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 00:34:54 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 00:34:54 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 00:34:54 INFO - Using env: {'DISPLAY': ':0', 00:34:54 INFO - 'HOME': '/home/cltbld', 00:34:54 INFO - 'LANG': 'en_US.UTF-8', 00:34:54 INFO - 'LANGUAGE': 'en_US:en', 00:34:54 INFO - 'LOGNAME': 'cltbld', 00:34:54 INFO - 'MAIL': '/var/mail/cltbld', 00:34:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:34:54 INFO - 'MOZ_NO_REMOTE': '1', 00:34:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:34:54 INFO - 'NO_EM_RESTART': '1', 00:34:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:34:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:34:54 INFO - 'PWD': '/builds/slave/test', 00:34:54 INFO - 'SHELL': '/bin/bash', 00:34:54 INFO - 'SHLVL': '1', 00:34:54 INFO - 'TERM': 'linux', 00:34:54 INFO - 'TMOUT': '86400', 00:34:54 INFO - 'USER': 'cltbld', 00:34:54 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1452668763.40087-751281491', 00:34:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:34:54 INFO - '_': '/tools/buildbot/bin/python'} 00:34:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:34:54 INFO - Downloading/unpacking psutil>=0.7.1 00:34:54 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 00:34:54 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 00:34:54 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 00:34:54 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 00:34:54 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 00:34:54 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 00:34:56 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 00:34:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:34:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:34:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:34:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:34:56 INFO - Installing collected packages: psutil 00:34:56 INFO - Running setup.py install for psutil 00:34:56 INFO - building 'psutil._psutil_linux' extension 00:34:56 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 00:34:57 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 00:34:57 INFO - building 'psutil._psutil_posix' extension 00:34:57 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 00:34:57 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 00:34:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:34:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:34:57 INFO - Successfully installed psutil 00:34:57 INFO - Cleaning up... 00:34:57 INFO - Return code: 0 00:34:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:34: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')]} 00:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:34:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34: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')]} 00:34:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:34:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34:57 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 0x7fa7bf072f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeae3d0>, '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 0xe19ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1a360>, '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': '920470bf432669ad7e3a5387000001ca-1452668763.40087-751281491', '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 00:34:57 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 00:34:57 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 00:34:57 INFO - Using env: {'DISPLAY': ':0', 00:34:57 INFO - 'HOME': '/home/cltbld', 00:34:57 INFO - 'LANG': 'en_US.UTF-8', 00:34:57 INFO - 'LANGUAGE': 'en_US:en', 00:34:57 INFO - 'LOGNAME': 'cltbld', 00:34:57 INFO - 'MAIL': '/var/mail/cltbld', 00:34:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:34:57 INFO - 'MOZ_NO_REMOTE': '1', 00:34:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:34:57 INFO - 'NO_EM_RESTART': '1', 00:34:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:34:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:34:57 INFO - 'PWD': '/builds/slave/test', 00:34:57 INFO - 'SHELL': '/bin/bash', 00:34:57 INFO - 'SHLVL': '1', 00:34:57 INFO - 'TERM': 'linux', 00:34:57 INFO - 'TMOUT': '86400', 00:34:57 INFO - 'USER': 'cltbld', 00:34:57 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1452668763.40087-751281491', 00:34:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:34:57 INFO - '_': '/tools/buildbot/bin/python'} 00:34:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:34:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:34:57 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 00:34:57 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 00:34:57 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 00:34:57 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 00:34:57 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 00:34:57 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 00:34:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:34:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:34:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:34:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:34:59 INFO - Installing collected packages: mozsystemmonitor 00:34:59 INFO - Running setup.py install for mozsystemmonitor 00:34:59 INFO - Successfully installed mozsystemmonitor 00:34:59 INFO - Cleaning up... 00:34:59 INFO - Return code: 0 00:34:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:34:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:34:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34:59 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 0x7fa7bf072f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeae3d0>, '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 0xe19ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1a360>, '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': '920470bf432669ad7e3a5387000001ca-1452668763.40087-751281491', '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 00:34:59 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 00:34:59 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 00:34:59 INFO - Using env: {'DISPLAY': ':0', 00:34:59 INFO - 'HOME': '/home/cltbld', 00:34:59 INFO - 'LANG': 'en_US.UTF-8', 00:34:59 INFO - 'LANGUAGE': 'en_US:en', 00:34:59 INFO - 'LOGNAME': 'cltbld', 00:34:59 INFO - 'MAIL': '/var/mail/cltbld', 00:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:34:59 INFO - 'MOZ_NO_REMOTE': '1', 00:34:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:34:59 INFO - 'NO_EM_RESTART': '1', 00:34:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:34:59 INFO - 'PWD': '/builds/slave/test', 00:34:59 INFO - 'SHELL': '/bin/bash', 00:34:59 INFO - 'SHLVL': '1', 00:34:59 INFO - 'TERM': 'linux', 00:34:59 INFO - 'TMOUT': '86400', 00:34:59 INFO - 'USER': 'cltbld', 00:34:59 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1452668763.40087-751281491', 00:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:34:59 INFO - '_': '/tools/buildbot/bin/python'} 00:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:34:59 INFO - Downloading/unpacking blobuploader==1.2.4 00:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:34:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:34:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:35:01 INFO - Downloading blobuploader-1.2.4.tar.gz 00:35:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:35:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:35:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:35:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:35:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:35:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:35:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:35:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:35:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:35:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:35:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:35:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:35:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:35:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:35:02 INFO - Downloading docopt-0.6.1.tar.gz 00:35:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:35:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:35:02 INFO - Installing collected packages: blobuploader, requests, docopt 00:35:02 INFO - Running setup.py install for blobuploader 00:35:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:35:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:35:02 INFO - Running setup.py install for requests 00:35:02 INFO - Running setup.py install for docopt 00:35:02 INFO - Successfully installed blobuploader requests docopt 00:35:02 INFO - Cleaning up... 00:35:02 INFO - Return code: 0 00:35:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:35: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')]} 00:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:35:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:35: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')]} 00:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:35:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:35:02 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 0x7fa7bf072f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeae3d0>, '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 0xe19ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1a360>, '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': '920470bf432669ad7e3a5387000001ca-1452668763.40087-751281491', '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 00:35:02 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 00:35:02 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 00:35:02 INFO - Using env: {'DISPLAY': ':0', 00:35:02 INFO - 'HOME': '/home/cltbld', 00:35:02 INFO - 'LANG': 'en_US.UTF-8', 00:35:02 INFO - 'LANGUAGE': 'en_US:en', 00:35:02 INFO - 'LOGNAME': 'cltbld', 00:35:02 INFO - 'MAIL': '/var/mail/cltbld', 00:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:35:02 INFO - 'MOZ_NO_REMOTE': '1', 00:35:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:35:02 INFO - 'NO_EM_RESTART': '1', 00:35:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:35:02 INFO - 'PWD': '/builds/slave/test', 00:35:02 INFO - 'SHELL': '/bin/bash', 00:35:02 INFO - 'SHLVL': '1', 00:35:02 INFO - 'TERM': 'linux', 00:35:02 INFO - 'TMOUT': '86400', 00:35:02 INFO - 'USER': 'cltbld', 00:35:02 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1452668763.40087-751281491', 00:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:35:02 INFO - '_': '/tools/buildbot/bin/python'} 00:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:35:02 INFO - Running setup.py (path:/tmp/pip-hyQClG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:35:02 INFO - Running setup.py (path:/tmp/pip-F8XKGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:35:03 INFO - Running setup.py (path:/tmp/pip-eVL8rq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:35:03 INFO - Running setup.py (path:/tmp/pip-_E8E8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:35:03 INFO - Running setup.py (path:/tmp/pip-e_ao1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:35:03 INFO - Running setup.py (path:/tmp/pip-MkbTq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:35:03 INFO - Running setup.py (path:/tmp/pip-JOEG5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:35:03 INFO - Running setup.py (path:/tmp/pip-oapm11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:35:03 INFO - Running setup.py (path:/tmp/pip-yGAi0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:35:03 INFO - Running setup.py (path:/tmp/pip-CzJQyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:35:03 INFO - Running setup.py (path:/tmp/pip-QIMkVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:35:03 INFO - Running setup.py (path:/tmp/pip-2Rk0jj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:35:03 INFO - Running setup.py (path:/tmp/pip-ptfkIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:35:03 INFO - Running setup.py (path:/tmp/pip-K9DM4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:35:03 INFO - Running setup.py (path:/tmp/pip-IVksVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:35:03 INFO - Running setup.py (path:/tmp/pip-3Qy6Sz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:35:04 INFO - Running setup.py (path:/tmp/pip-bO2eCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:35:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:35:04 INFO - Running setup.py install for manifestparser 00:35:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:35:04 INFO - Running setup.py install for mozcrash 00:35:04 INFO - Running setup.py install for mozdebug 00:35:04 INFO - Running setup.py install for mozdevice 00:35:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:35:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:35:04 INFO - Running setup.py install for mozfile 00:35:04 INFO - Running setup.py install for mozhttpd 00:35:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:35:04 INFO - Running setup.py install for mozinfo 00:35:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:35:04 INFO - Running setup.py install for mozInstall 00:35:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:35:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:35:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:35:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:35:04 INFO - Running setup.py install for mozleak 00:35:05 INFO - Running setup.py install for mozlog 00:35:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:35:05 INFO - Running setup.py install for moznetwork 00:35:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:35:05 INFO - Running setup.py install for mozprocess 00:35:05 INFO - Running setup.py install for mozprofile 00:35:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:35:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:35:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:35:05 INFO - Running setup.py install for mozrunner 00:35:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:35:05 INFO - Running setup.py install for mozscreenshot 00:35:05 INFO - Running setup.py install for moztest 00:35:05 INFO - Running setup.py install for mozversion 00:35:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:35:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:35:05 INFO - Cleaning up... 00:35:05 INFO - Return code: 0 00:35:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:35:05 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')]} 00:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:35:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:35:05 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')]} 00:35:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:35:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:35:05 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 0x7fa7bf072f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeae3d0>, '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 0xe19ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1a360>, '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': '920470bf432669ad7e3a5387000001ca-1452668763.40087-751281491', '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 00:35:05 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 00:35:05 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 00:35:05 INFO - Using env: {'DISPLAY': ':0', 00:35:05 INFO - 'HOME': '/home/cltbld', 00:35:05 INFO - 'LANG': 'en_US.UTF-8', 00:35:05 INFO - 'LANGUAGE': 'en_US:en', 00:35:05 INFO - 'LOGNAME': 'cltbld', 00:35:05 INFO - 'MAIL': '/var/mail/cltbld', 00:35:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:35:05 INFO - 'MOZ_NO_REMOTE': '1', 00:35:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:35:05 INFO - 'NO_EM_RESTART': '1', 00:35:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:35:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:35:05 INFO - 'PWD': '/builds/slave/test', 00:35:05 INFO - 'SHELL': '/bin/bash', 00:35:05 INFO - 'SHLVL': '1', 00:35:05 INFO - 'TERM': 'linux', 00:35:05 INFO - 'TMOUT': '86400', 00:35:05 INFO - 'USER': 'cltbld', 00:35:05 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1452668763.40087-751281491', 00:35:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:35:05 INFO - '_': '/tools/buildbot/bin/python'} 00:35:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:35:06 INFO - Running setup.py (path:/tmp/pip-72jhh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:35:06 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)) 00:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:35:06 INFO - Running setup.py (path:/tmp/pip-c7qryc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:35:06 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)) 00:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:35:06 INFO - Running setup.py (path:/tmp/pip-XwjKJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:35:06 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)) 00:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:35:06 INFO - Running setup.py (path:/tmp/pip-ewpXJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:35:06 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)) 00:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:35:06 INFO - Running setup.py (path:/tmp/pip-6YLGPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:35:06 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)) 00:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:35:06 INFO - Running setup.py (path:/tmp/pip-MIPSar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:35:06 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)) 00:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:35:06 INFO - Running setup.py (path:/tmp/pip-xRpFKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:35:06 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)) 00:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:35:06 INFO - Running setup.py (path:/tmp/pip-Uu8Hxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:35:06 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)) 00:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:35:06 INFO - Running setup.py (path:/tmp/pip-fgS4CN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:35:06 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)) 00:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:35:06 INFO - Running setup.py (path:/tmp/pip-T9N1Mm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:35:06 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)) 00:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:35:06 INFO - Running setup.py (path:/tmp/pip-3_1_I2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:35:06 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)) 00:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:35:06 INFO - Running setup.py (path:/tmp/pip-CLO2_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:35:06 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)) 00:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:35:06 INFO - Running setup.py (path:/tmp/pip-Mu4_QX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:35:07 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)) 00:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:35:07 INFO - Running setup.py (path:/tmp/pip-msIofq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:35:07 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)) 00:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:35:07 INFO - Running setup.py (path:/tmp/pip-yD2Urv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:35:07 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)) 00:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:35:07 INFO - Running setup.py (path:/tmp/pip-8BQNly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:35:07 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)) 00:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:35:07 INFO - Running setup.py (path:/tmp/pip-yXAPs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:35:07 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)) 00:35:07 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)) 00:35:07 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)) 00:35:07 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)) 00:35:07 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)) 00:35:07 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)) 00:35:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:35:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:35:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:35:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:35:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:35:09 INFO - Downloading blessings-1.5.1.tar.gz 00:35:09 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 00:35:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:35:09 INFO - Installing collected packages: blessings 00:35:09 INFO - Running setup.py install for blessings 00:35:09 INFO - Successfully installed blessings 00:35:09 INFO - Cleaning up... 00:35:09 INFO - Return code: 0 00:35:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:35:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:35:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:35:09 INFO - Reading from file tmpfile_stdout 00:35:09 INFO - Current package versions: 00:35:09 INFO - argparse == 1.2.1 00:35:09 INFO - blessings == 1.5.1 00:35:09 INFO - blobuploader == 1.2.4 00:35:09 INFO - docopt == 0.6.1 00:35:09 INFO - manifestparser == 1.1 00:35:09 INFO - mozInstall == 1.12 00:35:09 INFO - mozcrash == 0.16 00:35:09 INFO - mozdebug == 0.1 00:35:09 INFO - mozdevice == 0.47 00:35:09 INFO - mozfile == 1.2 00:35:09 INFO - mozhttpd == 0.7 00:35:09 INFO - mozinfo == 0.9 00:35:09 INFO - mozleak == 0.1 00:35:09 INFO - mozlog == 3.1 00:35:09 INFO - moznetwork == 0.27 00:35:09 INFO - mozprocess == 0.22 00:35:09 INFO - mozprofile == 0.28 00:35:09 INFO - mozrunner == 6.11 00:35:09 INFO - mozscreenshot == 0.1 00:35:09 INFO - mozsystemmonitor == 0.0 00:35:09 INFO - moztest == 0.7 00:35:09 INFO - mozversion == 1.4 00:35:09 INFO - psutil == 3.1.1 00:35:09 INFO - requests == 1.2.3 00:35:09 INFO - wsgiref == 0.1.2 00:35:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:35:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:35:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:35:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:35:09 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 0x7fa7bf072f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeae3d0>, '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 0xe19ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1a360>, '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': '920470bf432669ad7e3a5387000001ca-1452668763.40087-751281491', '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 00:35:09 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 00:35:09 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 00:35:09 INFO - Using env: {'DISPLAY': ':0', 00:35:09 INFO - 'HOME': '/home/cltbld', 00:35:09 INFO - 'LANG': 'en_US.UTF-8', 00:35:09 INFO - 'LANGUAGE': 'en_US:en', 00:35:09 INFO - 'LOGNAME': 'cltbld', 00:35:09 INFO - 'MAIL': '/var/mail/cltbld', 00:35:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:35:09 INFO - 'MOZ_NO_REMOTE': '1', 00:35:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:35:09 INFO - 'NO_EM_RESTART': '1', 00:35:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:35:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:35:09 INFO - 'PWD': '/builds/slave/test', 00:35:09 INFO - 'SHELL': '/bin/bash', 00:35:09 INFO - 'SHLVL': '1', 00:35:09 INFO - 'TERM': 'linux', 00:35:09 INFO - 'TMOUT': '86400', 00:35:09 INFO - 'USER': 'cltbld', 00:35:09 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1452668763.40087-751281491', 00:35:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:35:09 INFO - '_': '/tools/buildbot/bin/python'} 00:35:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:35:09 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)) 00:35:09 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)) 00:35:09 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)) 00:35:09 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)) 00:35:09 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)) 00:35:09 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)) 00:35:09 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)) 00:35:09 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)) 00:35:09 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)) 00:35:09 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)) 00:35:09 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)) 00:35:09 INFO - Cleaning up... 00:35:09 INFO - Return code: 0 00:35:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:35:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:35:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:35:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:35:09 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 0x7fa7bf072f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeae3d0>, '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 0xe19ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1a360>, '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': '920470bf432669ad7e3a5387000001ca-1452668763.40087-751281491', '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 00:35:09 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 00:35:09 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 00:35:09 INFO - Using env: {'DISPLAY': ':0', 00:35:09 INFO - 'HOME': '/home/cltbld', 00:35:09 INFO - 'LANG': 'en_US.UTF-8', 00:35:09 INFO - 'LANGUAGE': 'en_US:en', 00:35:09 INFO - 'LOGNAME': 'cltbld', 00:35:09 INFO - 'MAIL': '/var/mail/cltbld', 00:35:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:35:09 INFO - 'MOZ_NO_REMOTE': '1', 00:35:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:35:09 INFO - 'NO_EM_RESTART': '1', 00:35:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:35:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:35:09 INFO - 'PWD': '/builds/slave/test', 00:35:09 INFO - 'SHELL': '/bin/bash', 00:35:09 INFO - 'SHLVL': '1', 00:35:09 INFO - 'TERM': 'linux', 00:35:09 INFO - 'TMOUT': '86400', 00:35:09 INFO - 'USER': 'cltbld', 00:35:09 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1452668763.40087-751281491', 00:35:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:35:09 INFO - '_': '/tools/buildbot/bin/python'} 00:35:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:35:09 INFO - Downloading/unpacking jsonschema 00:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:35:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:35:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:35:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:35:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:35:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:35:11 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 00:35:11 INFO - Downloading/unpacking functools32 (from jsonschema) 00:35: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 00:35: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 00:35: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 00:35: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 00:35: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 00:35: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 00:35:11 INFO - Downloading functools32-3.2.3-2.tar.gz 00:35:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 00:35:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:35:11 INFO - warning: no files found matching '*.txt' 00:35:11 INFO - no previously-included directories found matching 'build' 00:35:11 INFO - no previously-included directories found matching 'dist' 00:35:11 INFO - no previously-included directories found matching '.git*' 00:35:11 INFO - Installing collected packages: jsonschema, functools32 00:35:11 INFO - Running setup.py install for functools32 00:35:12 INFO - warning: no files found matching '*.txt' 00:35:12 INFO - no previously-included directories found matching 'build' 00:35:12 INFO - no previously-included directories found matching 'dist' 00:35:12 INFO - no previously-included directories found matching '.git*' 00:35:12 INFO - Successfully installed jsonschema functools32 00:35:12 INFO - Cleaning up... 00:35:12 INFO - Return code: 0 00:35:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:35: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')]} 00:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:35:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:35: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')]} 00:35:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:35:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:35: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7bf072f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeae3d0>, '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 0xe19ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1a360>, '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': '920470bf432669ad7e3a5387000001ca-1452668763.40087-751281491', '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 00:35: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', 'flake8'] in /builds/slave/test/build 00:35: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 flake8 00:35:12 INFO - Using env: {'DISPLAY': ':0', 00:35:12 INFO - 'HOME': '/home/cltbld', 00:35:12 INFO - 'LANG': 'en_US.UTF-8', 00:35:12 INFO - 'LANGUAGE': 'en_US:en', 00:35:12 INFO - 'LOGNAME': 'cltbld', 00:35:12 INFO - 'MAIL': '/var/mail/cltbld', 00:35:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:35:12 INFO - 'MOZ_NO_REMOTE': '1', 00:35:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:35:12 INFO - 'NO_EM_RESTART': '1', 00:35:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:35:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:35:12 INFO - 'PWD': '/builds/slave/test', 00:35:12 INFO - 'SHELL': '/bin/bash', 00:35:12 INFO - 'SHLVL': '1', 00:35:12 INFO - 'TERM': 'linux', 00:35:12 INFO - 'TMOUT': '86400', 00:35:12 INFO - 'USER': 'cltbld', 00:35:12 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1452668763.40087-751281491', 00:35:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:35:12 INFO - '_': '/tools/buildbot/bin/python'} 00:35:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:35:12 INFO - Downloading/unpacking flake8 00:35:12 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 00:35:12 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 00:35:12 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 00:35:12 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 00:35:12 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 00:35:12 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 00:35:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:35:14 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 00:35:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:35: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 00:35: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 00:35: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 00:35: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 00:35: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 00:35: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 00:35:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:35:14 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 00:35:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:35: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 00:35: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 00:35: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 00:35: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 00:35: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 00:35: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 00:35:14 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 00:35:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:35: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 00:35: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 00:35: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 00:35: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 00:35: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 00:35: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 00:35:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 00:35:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:35:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:35:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:35:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:35:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:35:14 INFO - no previously-included directories found matching 'docs/_build' 00:35:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:35:14 INFO - Running setup.py install for pep8 00:35:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:35:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:35:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:35:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:35:14 INFO - no previously-included directories found matching 'docs/_build' 00:35:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:35:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:35:14 INFO - Cleaning up... 00:35:14 INFO - Return code: 0 00:35:14 INFO - Running post-action listener: _resource_record_post_action 00:35:14 INFO - Running post-action listener: _start_resource_monitoring 00:35:14 INFO - Starting resource monitoring. 00:35:14 INFO - ##### 00:35:14 INFO - ##### Running install step. 00:35:14 INFO - ##### 00:35:14 INFO - Running pre-action listener: _resource_record_pre_action 00:35:14 INFO - Running main action method: install 00:35:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:35:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:35:15 INFO - Reading from file tmpfile_stdout 00:35:15 INFO - Detecting whether we're running mozinstall >=1.0... 00:35:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:35:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:35:15 INFO - Reading from file tmpfile_stdout 00:35:15 INFO - Output received: 00:35:15 INFO - Usage: mozinstall [options] installer 00:35:15 INFO - Options: 00:35:15 INFO - -h, --help show this help message and exit 00:35:15 INFO - -d DEST, --destination=DEST 00:35:15 INFO - Directory to install application into. [default: 00:35:15 INFO - "/builds/slave/test"] 00:35:15 INFO - --app=APP Application being installed. [default: firefox] 00:35:15 INFO - mkdir: /builds/slave/test/build/application 00:35:15 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'] 00:35:15 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 00:35:30 INFO - Reading from file tmpfile_stdout 00:35:30 INFO - Output received: 00:35:30 INFO - /builds/slave/test/build/application/firefox/firefox 00:35:30 INFO - Running post-action listener: _resource_record_post_action 00:35:30 INFO - ##### 00:35:30 INFO - ##### Running run-tests step. 00:35:30 INFO - ##### 00:35:30 INFO - Running pre-action listener: _resource_record_pre_action 00:35:30 INFO - Running main action method: run_tests 00:35:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:35:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:35:30 INFO - Python 2.7.3 00:35:30 INFO - Return code: 0 00:35:30 INFO - grabbing minidump binary from tooltool 00:35:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:35:30 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 0xeae3d0>, '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 0xe19ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1a360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:35:30 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 00:35:30 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 00:35:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:35:30 INFO - Return code: 0 00:35:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:35:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:35:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:35:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:35:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:35:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:35:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:35:31 INFO - Return code: 0 00:35:31 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/apvA7PSFTCWjUAtS8fuDTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 00:35:31 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/apvA7PSFTCWjUAtS8fuDTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 00:35:31 INFO - Using env: {'DISPLAY': ':0', 00:35:31 INFO - 'HOME': '/home/cltbld', 00:35:31 INFO - 'LANG': 'en_US.UTF-8', 00:35:31 INFO - 'LANGUAGE': 'en_US:en', 00:35:31 INFO - 'LOGNAME': 'cltbld', 00:35:31 INFO - 'MAIL': '/var/mail/cltbld', 00:35:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:35:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:35:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:35:31 INFO - 'MOZ_NO_REMOTE': '1', 00:35:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:35:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:35:31 INFO - 'NO_EM_RESTART': '1', 00:35:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:35:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:35:31 INFO - 'PWD': '/builds/slave/test', 00:35:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:35:31 INFO - 'SHELL': '/bin/bash', 00:35:31 INFO - 'SHLVL': '1', 00:35:31 INFO - 'TERM': 'linux', 00:35:31 INFO - 'TMOUT': '86400', 00:35:31 INFO - 'USER': 'cltbld', 00:35:31 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1452668763.40087-751281491', 00:35:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:35:31 INFO - '_': '/tools/buildbot/bin/python'} 00:35:31 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/apvA7PSFTCWjUAtS8fuDTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 00:35:32 INFO - mozversion application_buildid: 20160112235630 00:35:32 INFO - mozversion application_changeset: a87a27864bb88946c005815272f225cb722f83e4 00:35:32 INFO - mozversion application_display_name: Nightly 00:35:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:35:32 INFO - mozversion application_name: Firefox 00:35:32 INFO - mozversion application_remotingname: firefox 00:35:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:35:32 INFO - mozversion application_vendor: Mozilla 00:35:32 INFO - mozversion application_version: 46.0a1 00:35:32 INFO - mozversion platform_buildid: 20160112235630 00:35:32 INFO - mozversion platform_changeset: a87a27864bb88946c005815272f225cb722f83e4 00:35:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:35:32 INFO - mozversion platform_version: 46.0a1 00:35:32 INFO - using testdate: 1452674132 00:35:32 INFO - actual date: 1452674132 00:35:32 INFO - starting webserver on 'localhost:44697' 00:35:32 INFO - SUITE-START | Running 3 tests 00:35:32 INFO - TEST-START | dromaeo_css 00:35:32 INFO - operating with platform_type : linux_ 00:35:32 INFO - Initialising browser for dromaeo_css test... 00:35:32 INFO - TEST-INFO | started process 10101 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6HcHaB/profile http://localhost:44697/getInfo.html) 00:35:36 INFO - PROCESS | 10101 | 00:35:36 INFO - PROCESS | 10101 | (process:10181): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:35:37 INFO - PROCESS | 10101 | __metrics Screen width/height:1600/1200 00:35:37 INFO - PROCESS | 10101 | colorDepth:24 00:35:37 INFO - PROCESS | 10101 | Browser inner width/height: 1024/697 00:35:37 INFO - PROCESS | 10101 | __metrics 00:35:37 INFO - PROCESS | 10101 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 00:35:38 INFO - TEST-INFO | 10101: exit 0 00:35:38 INFO - Browser initialized. 00:35:38 INFO - Running cycle 1/1 for dromaeo_css test... 00:35:38 INFO - TEST-INFO | started process 10232 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6HcHaB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:35:39 INFO - PROCESS | 10232 | 00:35:39 INFO - PROCESS | 10232 | (process:10288): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:35:50 INFO - PROCESS | 10232 | RSS: Main: 150151168 00:35:50 INFO - PROCESS | 10232 | 00:36:39 INFO - PROCESS | 10232 | 1452674199852 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] 00:38:51 INFO - PROCESS | 10232 | Cycle 1(1): loaded http://localhost:44697/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44697/tests/dromaeo/cssquery-ext.html) 00:38:52 INFO - PROCESS | 10232 | RSS: Main: 148852736 00:38:52 INFO - PROCESS | 10232 | 00:41:54 INFO - PROCESS | 10232 | Cycle 1(1): loaded http://localhost:44697/tests/dromaeo/cssquery-ext.html (next: http://localhost:44697/tests/dromaeo/cssquery-jquery.html) 00:41:54 INFO - PROCESS | 10232 | RSS: Main: 150302720 00:41:54 INFO - PROCESS | 10232 | 00:44:56 INFO - PROCESS | 10232 | Cycle 1(1): loaded http://localhost:44697/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44697/tests/dromaeo/cssquery-mootools.html) 00:44:57 INFO - PROCESS | 10232 | RSS: Main: 150925312 00:44:57 INFO - PROCESS | 10232 | 00:47:59 INFO - PROCESS | 10232 | Cycle 1(1): loaded http://localhost:44697/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44697/tests/dromaeo/cssquery-prototype.html) 00:47:59 INFO - PROCESS | 10232 | RSS: Main: 153272320 00:47:59 INFO - PROCESS | 10232 | 00:51:02 INFO - PROCESS | 10232 | Cycle 1(1): loaded http://localhost:44697/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44697/tests/dromaeo/cssquery-yui.html) 00:51:02 INFO - PROCESS | 10232 | RSS: Main: 151498752 00:51:02 INFO - PROCESS | 10232 | 00:54:05 INFO - PROCESS | 10232 | Cycle 1(1): loaded http://localhost:44697/tests/dromaeo/cssquery-yui.html (next: http://localhost:44697/tests/dromaeo/cssquery-dojo.html) 00:54:05 INFO - PROCESS | 10232 | RSS: Main: 150388736 00:54:05 INFO - PROCESS | 10232 | 00:54:05 INFO - PROCESS | 10232 | __start_tp_report 00:54:05 INFO - PROCESS | 10232 | _x_x_mozilla_page_load 00:54:05 INFO - PROCESS | 10232 | _x_x_mozilla_page_load_details 00:54:05 INFO - PROCESS | 10232 | |i|pagename|runs| 00:54:05 INFO - PROCESS | 10232 | |0;dojo.html;2606.374470127169;2619.567771317733;2650.2446802661248;2661.2415461593437;2664.5203863304605;4373.147236288925;4468.776561171941;4471.463424389078;4485;4543.409356783622;4398.362237475572;4513.2101882170655;4589.518100599439;4620.607248383883;4684.672072954894;4048.777317247565;4258.190943720683;4279.33670281107;4316.762578058206;4370.584794444539;4121.5878412158845;4323.265044942367;4339.956600434002;4350.847720329789;4360.847370342039;4123.051698109437;4177.895552611179;4243.639290660267;4243.830246790125;4262.616364527207;4182.1008483176265;4187.706860519765;4201.747895126302;4215.45199124115;4232.32282834748;4165.958340416587;4171.20747058058;4176.812043458051;4199.790010499462;4227.682923780698;4463.397441345442;4536.251518499444;4536.34223037661;4544.113897789933;4560.110778398213;4769.928451073237;4784.928226076611;4794.832180873687;4828.179209534387;4838.153323168432;4750.596199323062;4845.636577256684;4854.6359023073055;4926.187179115442;4985.152524070917;4495.550444955478;4509.706869053501;4517.9774101129615;4528.343390208402;4569;4980.427250866124;4991.975040124777;5005.649604527648;5006.173981293119;5062.544371006627;4664.137134630037;4806.975965120222;4807.230843065093;4808.06242782654;4869.732164730974;4816.060868130681;4823.469418363977;4855.781489832966;4865.6107511399005;4905.656604037755;4830.347903033045;4839.467658557556;4854.2233242681;4865.343178670905;4903.485134060944;4643.326717625925;4689.226277664216;4767.284907263869;4825.831095911696;4879.780409881564;3965.0285680008583;3966.0283230608684;3966.3058964681063;4007.1184339445276;4028.798560071985;3551.271989242199;3566.411542095525;3573.6426357364057;3585.5338805955057;3598.2803439312243;4173.457450531411;4244.702870799076;4247.065645557972;4282.678799090018;4286.935695964563;4823.975880120647;4900.26496025599;4915.36100306965;4915.729634870117;4960.950390496048;4142;4165.541790403053;4167.791610419466;4169.728967617095;4195.223883581547;4202.201581699467;4241.257779888507;4247.256730072225;4255.8084886180195;4319.762413067248;4593;4601.44782626087;4635.0498147878925;4661.091087237956;4685.718856868599;4889.462159162418;4900.362952816111;4921.237208232729;4921.753912304299;4928;4482.820687172477;4571.451425828922;4596.402467679314;4680.344751734692;4690.413698287714;4796.592289655418;4816.373871396696;4825.565699087099;4838.661293709407;4845.830395936126;4862.294967229661;4862.41651001882;4887.120318342732;4899.216125420058;4936.7284799336385;4604.608608268335;4682.063587282625;4718.480967093548;4737.431508219036;4829.541193586604;4759.2147295697205;4761.523847615211;4772.6181905448175;4785.784639691153;4811.975940120417;4662.0442809224705;4662.184117779308;4667.066586682609;4676.158291507561;4717.386739723814;4590.839320623762;4654.418197725285;4656.068786242833;4708.105459962596;4795.088933102699;4692.812287508462;4694.06118776253;4694.108119457293;4701.764911754331;4754.168020596313 00:54:05 INFO - PROCESS | 10232 | |1;ext.html;481.72541651258774;520.8775937654652;542.3329304954906;545.6344249352933;548.8819903720699;34925.82537087314;35650;35657.64342356576;35660.64339356605;35795.64204357956;40626.59373406265;40986.18027639445;41081.17837643253;41142.382864256986;41252.38121428173;7742.109657389387;7801.531908085504;7894.881576776353;7901.881471777928;7904.683812647487;7700.229977002311;7787.88318175225;7874.606269686521;7891.21087891212;7892.013498312711;7834.647440865147;7917.722879699211;7926.722564710236;7947.841043179133;7951.045874495068;7807.063152421717;7813.687452501865;7863.410244231648;7879;7901.525908445512;7730.033745781778;7873.267881066156;7876.17300183484;7886.605669716491;7900.723474678416;36836.0790980225;37439.25121497582;37485.81257093697;37550.624493754985;37573.81213093917;2601.5447296722996;2692.3269182704325;2712.6744790625053;2734.6581677290337;3146.7639927005566;27974.580381294298;28139.577906331422;28471.145865623857;28659.42681146386;28785.856070719514;3342.8495717692763;3389.8983030509125;3480.4083305838067;3505.719542436599;3536.504889315498;212613;213997.99999999846;214224;214624;215443;37455.62544374576;51958.74020629948;52288.21567676488;52367.476325237025;52402.47597524052;36523;36630.63369366326;36748;36832;36842;12304.323262220663;12327.137100403064;12365.629031129081;12473.812892806614;12477.376131193403;9190.035046320174;9256.213221876082;9265.675701350556;9276.16514513697;9278.072192780668;12867.42096605655;12938.288394138224;13144.934275328562;13266.602001939764;13287.601371958857;5327.493888080626;5450.345958485007;5507.834764957058;5534.695591742493;5539;825.7770401991429;836.4061516323478;860.6299291304799;948.3124734567383;992.3053862296422;24991.5001699965;25379.74620253774;25455.236342909742;25502.74497255041;25554.10560630369;892.1970226795806;957.5020989085637;983.179045497018;992.3549692699659;1068.0654427376046;14700;15025.624359391102;15199.088054716753;15325.846741532665;15594.220288985733;245798;247906;248738;248972;249607;48208;49283.75358123187;49671;49747;49912.50087499079;1164.574930150506;1171.191877604433;1172.554429316854;1208.3414539076225;1220.9023278137906;27008.59487107734;27164;27271.590926135726;27433.725662743116;27619.51424371816;38756.6124338753;39260.214795704494;39293.607063929;39325.80337098296;39383.21233575255;243051;245670;245696;245978;246537;28486.857565712868;29250.414991700472;39333.21333573255;40040.799796002;40137.1972560553;34675.65324346724;35106.64893351034;35562.82218588994;35738;35751.64248357483;32532.34935301328;32803.67196328102;32992;33970.15074623154;33970.49044264387;32833.179170520925;33363;33913.66086339204;35375;36116.45825312675;30233.69766302397;30846;32916;32973.50539741858;33216.501752474214;28929.42141157207;29931.251718706335;30510.590902961223;30831.2292192688;33943;23778.881105595054;24014;24119.276421707378;24283.757162428148;24841 00:54:05 INFO - PROCESS | 10232 | |2;jquery.html;350.8491348720051;351.16598079561044;352.37981153170426;352.494170864809;353.58630402429156;14449.927750361247;14799;14826.258687065658;15567.455139070134;16257.430989915341;9431.905680943206;9691.273154513405;10961.397123158224;13931;14168.858311416883;4150.128473020662;4307.633851122659;4321.6326612238;4327.653787696977;4802.471728109905;4903.901921961558;4934.80260789568;4936.605071594264;4938.234573641092;4944.802207911679;5120.974395128019;5676.97814393409;5714.171445140452;5908.793192238272;5951.375105613914;6015.308239552463;6024.427679370453;6033.577649564532;6636.004599310094;6670.833229169261;5804.2744656917885;6346.397092276273;6372.044193370985;6385.201849768779;6388.361163883621;19186.424407267805;19487.317943871898;19624.901875490676;20353.185872565078;20765.442591805677;1824.7354133650679;1831.2766457249445;1898.515878451;1900.9904950475159;1941.175000624743;12850.485980560767;12907.096503244777;13061.673458163621;13397.995150363762;13399.409510773208;1832.9175187116612;1839.0804597701149;1847.6581832361055;1866.1602278974515;1925.9133338999638;56444.71777641086;57233.14150287749;57407;58112;58598.7070064647;14562.85437145615;14628.853711462962;14695.191764452844;14779;14986.70026599462;21689;21809.709980452142;21863.12547498114;22101.778982209973;22190.445238869157;8262.462939908886;8298.045724741733;8313.210245026712;8317.584120793936;8341.624626891804;6828.2488926218075;6882.03651488792;6899;6942.826429339307;6963.617001064888;7214.96392518034;7319.451041171933;7344.853102937911;7368.410527157815;7405.555666660018;1711.6662250861211;1772.4151030160274;2929.765618750495;2963.777716671258;3052;781.984360312802;805.9153788852203;848.804774901776;876.4741155306765;929.5166513412987;14265.500707475188;14572.344244509022;14677.853221467649;15067.623309417353;15135.924320378328;818.9877151842727;842.4439869685978;848.6393282854762;862.779991102265;929.3958926697701;8557.27263182624;8567.74296771098;8835.911640883509;9034.548272586344;9479.857802132974;473894;475133;499006;500547;505644;63334.68332658307;63561.68219158967;63805.68097159485;64093.67953160204;64286.67856660687;1033.1476531861244;1085.8968398002178;1086.4567716141771;1094.0591091661324;1104.972375690598;13490.52783152585;13684.452621895012;13812.86187138156;13961.232132232824;14152.929235353757;30465.23836904095;30661.693383065885;30848;31015.53476697806;31108.222294441915;42705.57294427016;43486.34770478508;43765.56234437615;44963.55036449724;44978.77510612426;6361.363863613602;6491.221053473613;6594.604323740591;6602.7689030883685;6808.319168083152;7221;9781.559829807818;10029.197664186993;10076.899231007596;10310.845337319795;8224.276743329585;8321.916780832356;8405.285550728257;8414.4109912308;8520.659173632985;9149.405288656217;9322;9428.858567121362;9503.904960950578;9720.854187187339;8201.384896132933;8486.363522735695;8585.527795971282;8771.91228087711;8817.955910220664;6912.792616221522;7028.789136325919;7041.647917604202;7176.461765367722;7221.169565500035;7249.746258880914;8889.599968001585;8934.776630584287;8956.955215223883;8966.730998070068 00:54:05 INFO - PROCESS | 10232 | |3;mootools.html;1311.3705421397729;1381.903266771326;1454.934527946243;1726.689195944731;1757.9912100439487;6997.545159564625;7130.286971302874;7273.381762550176;7328.157261914881;7336.706531738724;7326.230745771697;7339;7419.07261592301;7430.851382972337;7432.145303290124;2146.474113842107;2177.1073859717517;2178.117862265785;2183.1376606240524;2191.276878630056;2217.5010622609943;2218.5784700906775;2261.050358849287;2261.3555136786017;2265.5355652091366;1754.456118603237;1796.0391190712971;2139.358192542239;2177.4991751897073;2207.2716003718815;2155.245664017597;2170.9891450542727;2181.345596321113;2184.432047667602;2186.5517568898335;2073.782252863443;2149.2370208575885;2160.8703477791228;2170.25126331417;2179.9564008719735;7200.495965282433;7221.638918054076;7230.349268565854;7239.131304243525;7240.746573869889;4157.750534967881;4266.0827921996915;4267.253230684649;4270.167317373113;4282.528921818597;2750.9037183698474;2773.514634938898;2781.1378472673537;2789.5536714125847;2792.2042217967983;801.5791709352578;839.1524560194248;841.7348535211389;896.0770406481334;910.6084383715;9622.518874056339;9840.852387214127;9843.064908833649;9843.803123937481;9845.064718851769;3862.304785138702;3961.2869683457257;4016.2971479990883;4088.693347998912;4137.358709400048;8602.741917742478;8615.267702245379;8642.524661143698;8663.91336086631;8673.392862499564;4322.330038843984;4334.523202447728;4364.3017117261725;4374.19077470669;4379.343098535245;3895.162540053902;3900.7074469414906;3927.0575061985487;3935.6064393560987;3950.20995800841;3266.2324353776844;3447.5518182636597;3461.8615255390005;3463.0130412832223;3471.0628130405153;1039.6465201831263;1080.0657431322006;1080.1358912869673;1088.031651829872;1090.7763908398758;788.8974433323746;801.2308184143171;833.9332853371716;915.4827522449795;917.27535247154;6364.6181229126405;6513.609183449008;6529;6530.2816690164045;6558.737650494022;538.5530010091614;552.2268823646846;558.5643198305328;560.2380762163455;697.2713514377488;5033.2701758245585;5086.72023038729;5088.643794934319;5097.541221290102;5100.821471248562;8307.335413166933;8550.914490855137;8612.440191387539;8680.131986801396;8703.521306328214;8568.657253709907;8574.356923230782;8590.355723320776;8602.440841345293;8616.870746938801;6782.660866956632;6860.382565569123;6861.828454288683;6923.376896079377;6955.478339124586;6837.1111755471475;6931.09895713554;6934.895976560457;6938.202106757787;6980.092587963532;7834.334081603128;8180.304674102768;8201.343892488467;8217.096119426978;8400.705975290835;8247.463914845515;8461.23848853606;8524.659013639384;8546.316294696533;8595.65617375298;6232.8130156095385;6235.282942461675;6302.873942521215;6311.621302721851;6337.176167098248;6545.2800191979795;6627.867442651216;6636.634985075867;6643.236027856665;6644.169478815148;6323.841903952438;6328.746850125944;6369.617822930639;6427.710753016219;6569.9014514783275;5504.504594586507;5923.614965027259;6232.626042437469;6311.526635502448;6381.489480841615;6022.879542409215;6172.660503672341;6313.273973493107;6374.872502549831;6406.679666016774;6053.667048312385;6074.90887636677;6092.512598991982;6103.786367477117;6112;5967.075103358986;5980.700964951648;5995.760169593342;6003.249593800775;6013.639181649115 00:54:05 INFO - PROCESS | 10232 | |4;prototype.html;294.78186142254725;298.51342312031386;298.84460080758004;298.99402011959774;302.67764830455565;5556.999740046795;5579.4699503547145;5638.295213098363;5654.293213348336;5678.43215678432;5537.778488860441;5539.612227144102;5551.1673249012665;5554.305711786027;5555.166724991253;4047.7166598338126;4243.236217480852;4249.957500425003;4250.234957707604;4257.318828987362;4136.937945930814;4137.027798467358;4257.787110644471;4257.914841703164;4261.4673165854265;4185.455890734215;4196.538380778112;4204.474440694913;4214.157168566284;4221.936670949938;4203.0543127796;4208.148414697524;4208.537060923296;4212.389203565466;4213.6839737019845;3688.207035487383;3691.3909204981146;3691.8338674759702;3695.9076023099637;3698.8705395311304;5210.348706411699;5350.839474815762;5363.088274993261;5365.812196573102;5390.4879036491475;4847.733374664392;4862.610991120702;4869.318295438641;4872.123017856784;4876.829310974134;5779.422057794229;5785.768569257225;5791.768329266824;5794.275715535558;5797.797077102281;4025.677945764332;4029.37544680575;4030.5969403059753;4034.4755181826467;4036.091879327128;5981.461668449817;6111.236095488064;6123.663198524079;6125.479334256594;6136.907946380852;4150.709450338447;4151.12826306473;4156.314208155621;4156.896077598084;4160.292750232467;4184.330507118846;4215.852445164404;4224.894377640522;4226.387173859773;4226.5773422657485;4829.806807727722;4830;4832.879178020507;4836.758162091881;4844.4186697596515;5688.715564221772;5754.769809207669;5780.046292361797;5795.913061304083;5802.651840889475;1443.826740791112;1496.4388354367113;1500.6248437890526;1500.6998600279987;1501.3544176004423;1009.9849651100596;1022.325265324882;1041.880183778875;1045.6235755128148;1057.984130238047;5065.544101030851;5086.847394578169;5100.6429549931145;5101.821436249714;5105.2342148678;5981.491573216238;6040.184575082308;6042.093685947055;6130.141780150782;6140.263168419819;5111.616628752859;5130.948690513047;5148.819791307361;5158.690478571298;5164.767585458663;3257.006612983063;3270.5094235864813;3278.262390962062;3279.2785587170783;3291.374638818617;5630.4369563043365;5736.77052917887;5738.942610573924;5754.6547207167705;5757.193992841006;6227.532935029891;6257.78097766576;6279.905801412982;6286;6292.465140463112;5712.400197979152;5741.282339707536;5743.712814359265;5748.971255143698;5767.250257466587;6067.787627433196;6069.848253793514;6097.634141951497;6104.633721976696;6108.11432342299;5694.686792226467;5864.06175011996;5938.287405511366;5946.226990491208;5955.40445955401;5660.4905558498285;5703.686297253691;5716.456936591017;5752.539796816328;5772.913406298825;4005.9399109012807;4008.398740188995;4024.5170579530645;4027.154297597537;4044.8179831908224;5948.553858460719;6062.818115456544;6102.389761023862;6103.7253323601435;6119.388061193845;5864.914990726729;5865.237519122486;5867;5869.73586188614;5878.412158784087;5835.591508594527;5865;5876.588638795243;5878.441548052928;5879.118132280021;5633.464820842013;5722.484976352148;5754.56840736938;5756.769729210785;5758.856028599151;5896.321922978912;5909.91135132982;5926.822195334147;5928.8814223716145;5933.673647949232;5766.711664416678;5770.076787713946;5779.450952159538;5808.709564521672;5811.4479124483105 00:54:05 INFO - PROCESS | 10232 | |5;yui.html;761.7181642792167;771.1928579968915;775.0428221146883;778.6729573579096;821.6179476543408;11370.09039276858;11457.427128643576;11566.53733850646;11613.303201807887;11640.18518703689;10044.99550044997;11068.667939961813;11393.145514086435;11412.42937853106;11469.31184128953;758.7306506190306;775.8370742144128;776.4719990406521;776.5690042026673;779.9727009554666;783.7335305995961;783.9137694853562;786.7325109462781;786.799366161628;790.2690011739147;818.6561644109488;820.0651257566379;821.1378053044309;821.1542111625006;823.1192623892438;810.3031393002013;812.9268365847103;813.0203105258149;813.6257321632027;817.2440492544432;606.8998615228483;607.6931149769382;608.5831205624118;610.4018062298971;610.4414460768392;10606.257561970666;10612.575496980111;10626.415547144903;10647.57409703611;10685.519151638195;9679.612815487371;9777.706668799876;9842.360246583949;9848.556814943344;10261.333013354108;7846.646900889474;8065.072516660601;8617.61220745068;8649.783755406103;8696;3094.5358196270513;3128.4212420702243;3159.08386567895;3166.730827879633;3199.3441344524317;37506.62493375059;37578.62421375779;38126.42482902042;38148;38371;9019.143181397756;9025.458472491671;9072.183503484717;9092.81814363709;9336.859947100664;14686.87040379139;15053.548393548212;15058.171800551076;15093.773593396108;15104.622384440258;6431.517636177212;6458.806235812933;6460.806175814733;6477.287498375175;6494.4479719223455;3464.255185135208;3491.5810102787827;3513.543239378864;3565.5186549815962;3619.261630855214;2699.298182472571;2722.7957903157344;2725.441284536665;2728.331558768075;2730.1536523677723;487.9487653796371;489.6768133032182;492.97781599828096;498.5811917988834;499.9325091112726;452.3508764922347;494.9331840201599;499.8850264439199;567.1690972724978;605.5065121925617;7611.581363024976;7725.343345815556;7850.803729906798;7966.243206895336;7987.920120798718;438.28121880116;567.7501899164355;612.0024360292695;617.4072890025536;619.4796371048341;3547.9290414191573;3692.7599706019023;3725.5343082114737;3773.64150405711;3793.260314238697;44095.33856992148;46742.532574673816;47320;47342.76328618335;47451.762741186074;40703.79648101741;41848;45347.09305813865;47933.28100078501;48258;32256.35487290241;33782.15544611404;40613.79693101575;42910.7854460732;43152.568474315485;7620.314171724572;7784.026996625422;8031.55826429552;8184;8262.462939908886;27399;27781.722182777914;27944.44111117807;28422;28468;37117.81441092777;37247.25505489821;37292;37317.25365492621;37820.810895945346;9698.70903872885;9734.561944712646;10322.690319290434;10356.119729822749;10776.191785615953;11236.269642473213;11281.887181128412;11299.209055366375;11356.772864542498;11365.033972112464;10566.841497377392;10664.306820056672;10696.304740191863;10955.61655342091;11183.888161118284;9324.974252832048;9660.516974151124;10168.186545076229;10794;11043.061339786209;8906.510141942255;9673.613055477703;10001.249906256915;10452.947735261276;10562.207834412604;8889.155530224618;9088.818223635622;9178.954105229432;9217.170454659114;9443.150116489274;8568.271696905584;8654.956725216334;8720.21518063352;8804.955975220339;9049.819003620023 00:54:05 INFO - PROCESS | 10232 | __end_tp_report 00:54:05 INFO - PROCESS | 10232 | __start_cc_report 00:54:05 INFO - PROCESS | 10232 | _x_x_mozilla_cycle_collect,331 00:54:05 INFO - PROCESS | 10232 | __end_cc_report 00:54:05 INFO - PROCESS | 10232 | __startTimestamp1452675245605__endTimestamp 00:54:05 INFO - PROCESS | 10232 | 00:54:05 INFO - PROCESS | 10232 | ------- Summary: start ------- 00:54:05 INFO - PROCESS | 10232 | Number of tests: 6 00:54:05 INFO - PROCESS | 10232 | 00:54:05 INFO - PROCESS | 10232 | [#0] dojo.html Cycles:165 Average:4496.51 Median:4643.33 stddev:462.60 (10.0%) stddev-sans-first:439.62 00:54:05 INFO - PROCESS | 10232 | Values: 2606.4 2619.6 2650.2 2661.2 2664.5 4373.1 4468.8 4471.5 4485.0 4543.4 4398.4 4513.2 4589.5 4620.6 4684.7 4048.8 4258.2 4279.3 4316.8 4370.6 4121.6 4323.3 4340.0 4350.8 4360.8 4123.1 4177.9 4243.6 4243.8 4262.6 4182.1 4187.7 4201.7 4215.5 4232.3 4166.0 4171.2 4176.8 4199.8 4227.7 4463.4 4536.3 4536.3 4544.1 4560.1 4769.9 4784.9 4794.8 4828.2 4838.2 4750.6 4845.6 4854.6 4926.2 4985.2 4495.6 4509.7 4518.0 4528.3 4569.0 4980.4 4992.0 5005.6 5006.2 5062.5 4664.1 4807.0 4807.2 4808.1 4869.7 4816.1 4823.5 4855.8 4865.6 4905.7 4830.3 4839.5 4854.2 4865.3 4903.5 4643.3 4689.2 4767.3 4825.8 4879.8 3965.0 3966.0 3966.3 4007.1 4028.8 3551.3 3566.4 3573.6 3585.5 3598.3 4173.5 4244.7 4247.1 4282.7 4286.9 4824.0 4900.3 4915.4 4915.7 4961.0 4142.0 4165.5 4167.8 4169.7 4195.2 4202.2 4241.3 4247.3 4255.8 4319.8 4593.0 4601.4 4635.0 4661.1 4685.7 4889.5 4900.4 4921.2 4921.8 4928.0 4482.8 4571.5 4596.4 4680.3 4690.4 4796.6 4816.4 4825.6 4838.7 4845.8 4862.3 4862.4 4887.1 4899.2 4936.7 4604.6 4682.1 4718.5 4737.4 4829.5 4759.2 4761.5 4772.6 4785.8 4812.0 4662.0 4662.2 4667.1 4676.2 4717.4 4590.8 4654.4 4656.1 4708.1 4795.1 4692.8 4694.1 4694.1 4701.8 4754.2 00:54:05 INFO - PROCESS | 10232 | 00:54:05 INFO - PROCESS | 10232 | [#1] ext.html Cycles:180 Average:39092.46 Median:35606.41 stddev:61498.96 (172.7%) stddev-sans-first:61603.15 00:54:05 INFO - PROCESS | 10232 | Values: 481.7 520.9 542.3 545.6 548.9 34925.8 35650.0 35657.6 35660.6 35795.6 40626.6 40986.2 41081.2 41142.4 41252.4 7742.1 7801.5 7894.9 7901.9 7904.7 7700.2 7787.9 7874.6 7891.2 7892.0 7834.6 7917.7 7926.7 7947.8 7951.0 7807.1 7813.7 7863.4 7879.0 7901.5 7730.0 7873.3 7876.2 7886.6 7900.7 36836.1 37439.3 37485.8 37550.6 37573.8 2601.5 2692.3 2712.7 2734.7 3146.8 27974.6 28139.6 28471.1 28659.4 28785.9 3342.8 3389.9 3480.4 3505.7 3536.5 212613.0 213998.0 214224.0 214624.0 215443.0 37455.6 51958.7 52288.2 52367.5 52402.5 36523.0 36630.6 36748.0 36832.0 36842.0 12304.3 12327.1 12365.6 12473.8 12477.4 9190.0 9256.2 9265.7 9276.2 9278.1 12867.4 12938.3 13144.9 13266.6 13287.6 5327.5 5450.3 5507.8 5534.7 5539.0 825.8 836.4 860.6 948.3 992.3 24991.5 25379.7 25455.2 25502.7 25554.1 892.2 957.5 983.2 992.4 1068.1 14700.0 15025.6 15199.1 15325.8 15594.2 245798.0 247906.0 248738.0 248972.0 249607.0 48208.0 49283.8 49671.0 49747.0 49912.5 1164.6 1171.2 1172.6 1208.3 1220.9 27008.6 27164.0 27271.6 27433.7 27619.5 38756.6 39260.2 39293.6 39325.8 39383.2 243051.0 245670.0 245696.0 245978.0 246537.0 28486.9 29250.4 39333.2 40040.8 40137.2 34675.7 35106.6 35562.8 35738.0 35751.6 32532.3 32803.7 32992.0 33970.2 33970.5 32833.2 33363.0 33913.7 35375.0 36116.5 30233.7 30846.0 32916.0 32973.5 33216.5 28929.4 29931.3 30510.6 30831.2 33943.0 23778.9 24014.0 24119.3 24283.8 24841.0 00:54:05 INFO - PROCESS | 10232 | 00:54:05 INFO - PROCESS | 10232 | [#2] jquery.html Cycles:180 Average:26069.55 Median:255382.49 stddev:80131.39 (31.4%) stddev-sans-first:80332.91 00:54:05 INFO - PROCESS | 10232 | Values: 350.8 351.2 352.4 352.5 353.6 14449.9 14799.0 14826.3 15567.5 16257.4 9431.9 9691.3 10961.4 13931.0 14168.9 4150.1 4307.6 4321.6 4327.7 4802.5 4903.9 4934.8 4936.6 4938.2 4944.8 5121.0 5677.0 5714.2 5908.8 5951.4 6015.3 6024.4 6033.6 6636.0 6670.8 5804.3 6346.4 6372.0 6385.2 6388.4 19186.4 19487.3 19624.9 20353.2 20765.4 1824.7 1831.3 1898.5 1901.0 1941.2 12850.5 12907.1 13061.7 13398.0 13399.4 1832.9 1839.1 1847.7 1866.2 1925.9 56444.7 57233.1 57407.0 58112.0 58598.7 14562.9 14628.9 14695.2 14779.0 14986.7 21689.0 21809.7 21863.1 22101.8 22190.4 8262.5 8298.0 8313.2 8317.6 8341.6 6828.2 6882.0 6899.0 6942.8 6963.6 7215.0 7319.5 7344.9 7368.4 7405.6 1711.7 1772.4 2929.8 2963.8 3052.0 782.0 805.9 848.8 876.5 929.5 14265.5 14572.3 14677.9 15067.6 15135.9 819.0 842.4 848.6 862.8 929.4 8557.3 8567.7 8835.9 9034.5 9479.9 473894.0 475133.0 499006.0 500547.0 505644.0 63334.7 63561.7 63805.7 64093.7 64286.7 1033.1 1085.9 1086.5 1094.1 1105.0 13490.5 13684.5 13812.9 13961.2 14152.9 30465.2 30661.7 30848.0 31015.5 31108.2 42705.6 43486.3 43765.6 44963.6 44978.8 6361.4 6491.2 6594.6 6602.8 6808.3 7221.0 9781.6 10029.2 10076.9 10310.8 8224.3 8321.9 8405.3 8414.4 8520.7 9149.4 9322.0 9428.9 9503.9 9720.9 8201.4 8486.4 8585.5 8771.9 8818.0 6912.8 7028.8 7041.6 7176.5 7221.2 7249.7 8889.6 8934.8 8957.0 8966.7 00:54:05 INFO - PROCESS | 10232 | 00:54:05 INFO - PROCESS | 10232 | [#3] mootools.html Cycles:180 Average:5043.24 Median:6269.08 stddev:2658.34 (42.4%) stddev-sans-first:2651.00 00:54:05 INFO - PROCESS | 10232 | Values: 1311.4 1381.9 1454.9 1726.7 1758.0 6997.5 7130.3 7273.4 7328.2 7336.7 7326.2 7339.0 7419.1 7430.9 7432.1 2146.5 2177.1 2178.1 2183.1 2191.3 2217.5 2218.6 2261.1 2261.4 2265.5 1754.5 1796.0 2139.4 2177.5 2207.3 2155.2 2171.0 2181.3 2184.4 2186.6 2073.8 2149.2 2160.9 2170.3 2180.0 7200.5 7221.6 7230.3 7239.1 7240.7 4157.8 4266.1 4267.3 4270.2 4282.5 2750.9 2773.5 2781.1 2789.6 2792.2 801.6 839.2 841.7 896.1 910.6 9622.5 9840.9 9843.1 9843.8 9845.1 3862.3 3961.3 4016.3 4088.7 4137.4 8602.7 8615.3 8642.5 8663.9 8673.4 4322.3 4334.5 4364.3 4374.2 4379.3 3895.2 3900.7 3927.1 3935.6 3950.2 3266.2 3447.6 3461.9 3463.0 3471.1 1039.6 1080.1 1080.1 1088.0 1090.8 788.9 801.2 833.9 915.5 917.3 6364.6 6513.6 6529.0 6530.3 6558.7 538.6 552.2 558.6 560.2 697.3 5033.3 5086.7 5088.6 5097.5 5100.8 8307.3 8550.9 8612.4 8680.1 8703.5 8568.7 8574.4 8590.4 8602.4 8616.9 6782.7 6860.4 6861.8 6923.4 6955.5 6837.1 6931.1 6934.9 6938.2 6980.1 7834.3 8180.3 8201.3 8217.1 8400.7 8247.5 8461.2 8524.7 8546.3 8595.7 6232.8 6235.3 6302.9 6311.6 6337.2 6545.3 6627.9 6636.6 6643.2 6644.2 6323.8 6328.7 6369.6 6427.7 6569.9 5504.5 5923.6 6232.6 6311.5 6381.5 6022.9 6172.7 6313.3 6374.9 6406.7 6053.7 6074.9 6092.5 6103.8 6112.0 5967.1 5980.7 5995.8 6003.2 6013.6 00:54:05 INFO - PROCESS | 10232 | 00:54:05 INFO - PROCESS | 10232 | [#4] prototype.html Cycles:180 Average:4829.65 Median:5538.70 stddev:1435.66 (25.9%) stddev-sans-first:1398.76 00:54:05 INFO - PROCESS | 10232 | Values: 294.8 298.5 298.8 299.0 302.7 5557.0 5579.5 5638.3 5654.3 5678.4 5537.8 5539.6 5551.2 5554.3 5555.2 4047.7 4243.2 4250.0 4250.2 4257.3 4136.9 4137.0 4257.8 4257.9 4261.5 4185.5 4196.5 4204.5 4214.2 4221.9 4203.1 4208.1 4208.5 4212.4 4213.7 3688.2 3691.4 3691.8 3695.9 3698.9 5210.3 5350.8 5363.1 5365.8 5390.5 4847.7 4862.6 4869.3 4872.1 4876.8 5779.4 5785.8 5791.8 5794.3 5797.8 4025.7 4029.4 4030.6 4034.5 4036.1 5981.5 6111.2 6123.7 6125.5 6136.9 4150.7 4151.1 4156.3 4156.9 4160.3 4184.3 4215.9 4224.9 4226.4 4226.6 4829.8 4830.0 4832.9 4836.8 4844.4 5688.7 5754.8 5780.0 5795.9 5802.7 1443.8 1496.4 1500.6 1500.7 1501.4 1010.0 1022.3 1041.9 1045.6 1058.0 5065.5 5086.8 5100.6 5101.8 5105.2 5981.5 6040.2 6042.1 6130.1 6140.3 5111.6 5130.9 5148.8 5158.7 5164.8 3257.0 3270.5 3278.3 3279.3 3291.4 5630.4 5736.8 5738.9 5754.7 5757.2 6227.5 6257.8 6279.9 6286.0 6292.5 5712.4 5741.3 5743.7 5749.0 5767.3 6067.8 6069.8 6097.6 6104.6 6108.1 5694.7 5864.1 5938.3 5946.2 5955.4 5660.5 5703.7 5716.5 5752.5 5772.9 4005.9 4008.4 4024.5 4027.2 4044.8 5948.6 6062.8 6102.4 6103.7 6119.4 5864.9 5865.2 5867.0 5869.7 5878.4 5835.6 5865.0 5876.6 5878.4 5879.1 5633.5 5722.5 5754.6 5756.8 5758.9 5896.3 5909.9 5926.8 5928.9 5933.7 5766.7 5770.1 5779.5 5808.7 5811.4 00:54:05 INFO - PROCESS | 10232 | 00:54:05 INFO - PROCESS | 10232 | [#5] yui.html Cycles:180 Average:11687.74 Median:48095.64 stddev:13130.25 (27.3%) stddev-sans-first:13141.45 00:54:05 INFO - PROCESS | 10232 | Values: 761.7 771.2 775.0 778.7 821.6 11370.1 11457.4 11566.5 11613.3 11640.2 10045.0 11068.7 11393.1 11412.4 11469.3 758.7 775.8 776.5 776.6 780.0 783.7 783.9 786.7 786.8 790.3 818.7 820.1 821.1 821.2 823.1 810.3 812.9 813.0 813.6 817.2 606.9 607.7 608.6 610.4 610.4 10606.3 10612.6 10626.4 10647.6 10685.5 9679.6 9777.7 9842.4 9848.6 10261.3 7846.6 8065.1 8617.6 8649.8 8696.0 3094.5 3128.4 3159.1 3166.7 3199.3 37506.6 37578.6 38126.4 38148.0 38371.0 9019.1 9025.5 9072.2 9092.8 9336.9 14686.9 15053.5 15058.2 15093.8 15104.6 6431.5 6458.8 6460.8 6477.3 6494.4 3464.3 3491.6 3513.5 3565.5 3619.3 2699.3 2722.8 2725.4 2728.3 2730.2 487.9 489.7 493.0 498.6 499.9 452.4 494.9 499.9 567.2 605.5 7611.6 7725.3 7850.8 7966.2 7987.9 438.3 567.8 612.0 617.4 619.5 3547.9 3692.8 3725.5 3773.6 3793.3 44095.3 46742.5 47320.0 47342.8 47451.8 40703.8 41848.0 45347.1 47933.3 48258.0 32256.4 33782.2 40613.8 42910.8 43152.6 7620.3 7784.0 8031.6 8184.0 8262.5 27399.0 27781.7 27944.4 28422.0 28468.0 37117.8 37247.3 37292.0 37317.3 37820.8 9698.7 9734.6 10322.7 10356.1 10776.2 11236.3 11281.9 11299.2 11356.8 11365.0 10566.8 10664.3 10696.3 10955.6 11183.9 9325.0 9660.5 10168.2 10794.0 11043.1 8906.5 9673.6 10001.2 10452.9 10562.2 8889.2 9088.8 9179.0 9217.2 9443.2 8568.3 8655.0 8720.2 8805.0 9049.8 00:54:05 INFO - PROCESS | 10232 | -------- Summary: end -------- 00:54:05 INFO - PROCESS | 10232 | 00:54:06 INFO - TEST-INFO | 10232: exit 0 00:54:06 INFO - TEST-OK | dromaeo_css | took 1114152ms 00:54:06 INFO - TEST-START | kraken 00:54:06 INFO - operating with platform_type : linux_ 00:54:06 INFO - Initialising browser for kraken test... 00:54:06 INFO - TEST-INFO | started process 10473 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNTrzrB/profile http://localhost:44697/getInfo.html) 00:54:10 INFO - PROCESS | 10473 | 00:54:10 INFO - PROCESS | 10473 | (process:10544): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:54:11 INFO - PROCESS | 10473 | __metrics Screen width/height:1600/1200 00:54:11 INFO - PROCESS | 10473 | colorDepth:24 00:54:11 INFO - PROCESS | 10473 | Browser inner width/height: 1024/697 00:54:11 INFO - PROCESS | 10473 | __metrics 00:54:11 INFO - PROCESS | 10473 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 00:54:12 INFO - TEST-INFO | 10473: exit 0 00:54:12 INFO - Browser initialized. 00:54:12 INFO - Running cycle 1/1 for kraken test... 00:54:12 INFO - TEST-INFO | started process 10593 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNTrzrB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:54:13 INFO - PROCESS | 10593 | 00:54:13 INFO - PROCESS | 10593 | (process:10649): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:54:24 INFO - PROCESS | 10593 | RSS: Main: 149639168 00:54:24 INFO - PROCESS | 10593 | 00:54:26 INFO - PROCESS | 10593 | Cycle 1(1): loaded http://localhost:44697/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44697/tests/kraken/driver.html?testName=audio-beat-detection) 00:54:27 INFO - PROCESS | 10593 | RSS: Main: 149311488 00:54:27 INFO - PROCESS | 10593 | 00:54:30 INFO - PROCESS | 10593 | Cycle 1(1): loaded http://localhost:44697/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44697/tests/kraken/driver.html?testName=audio-dft) 00:54:30 INFO - PROCESS | 10593 | RSS: Main: 150138880 00:54:30 INFO - PROCESS | 10593 | 00:54:33 INFO - PROCESS | 10593 | Cycle 1(1): loaded http://localhost:44697/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44697/tests/kraken/driver.html?testName=audio-fft) 00:54:34 INFO - PROCESS | 10593 | RSS: Main: 146497536 00:54:34 INFO - PROCESS | 10593 | 00:54:36 INFO - PROCESS | 10593 | Cycle 1(1): loaded http://localhost:44697/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44697/tests/kraken/driver.html?testName=audio-oscillator) 00:54:37 INFO - PROCESS | 10593 | RSS: Main: 146034688 00:54:37 INFO - PROCESS | 10593 | 00:54:39 INFO - PROCESS | 10593 | Cycle 1(1): loaded http://localhost:44697/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44697/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:54:40 INFO - PROCESS | 10593 | RSS: Main: 146468864 00:54:40 INFO - PROCESS | 10593 | 00:54:43 INFO - PROCESS | 10593 | Cycle 1(1): loaded http://localhost:44697/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44697/tests/kraken/driver.html?testName=imaging-darkroom) 00:54:43 INFO - PROCESS | 10593 | RSS: Main: 146784256 00:54:43 INFO - PROCESS | 10593 | 00:54:47 INFO - PROCESS | 10593 | Cycle 1(1): loaded http://localhost:44697/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44697/tests/kraken/driver.html?testName=imaging-desaturate) 00:54:47 INFO - PROCESS | 10593 | RSS: Main: 145596416 00:54:47 INFO - PROCESS | 10593 | 00:54:50 INFO - PROCESS | 10593 | Cycle 1(1): loaded http://localhost:44697/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44697/tests/kraken/driver.html?testName=json-parse-financial) 00:54:51 INFO - PROCESS | 10593 | RSS: Main: 146350080 00:54:51 INFO - PROCESS | 10593 | 00:54:53 INFO - PROCESS | 10593 | Cycle 1(1): loaded http://localhost:44697/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44697/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:54:53 INFO - PROCESS | 10593 | RSS: Main: 148033536 00:54:53 INFO - PROCESS | 10593 | 00:54:55 INFO - PROCESS | 10593 | Cycle 1(1): loaded http://localhost:44697/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44697/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:54:56 INFO - PROCESS | 10593 | RSS: Main: 147697664 00:54:56 INFO - PROCESS | 10593 | 00:54:58 INFO - PROCESS | 10593 | Cycle 1(1): loaded http://localhost:44697/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44697/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:54:58 INFO - PROCESS | 10593 | RSS: Main: 147615744 00:54:58 INFO - PROCESS | 10593 | 00:55:01 INFO - PROCESS | 10593 | Cycle 1(1): loaded http://localhost:44697/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44697/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:55:02 INFO - PROCESS | 10593 | RSS: Main: 147992576 00:55:02 INFO - PROCESS | 10593 | 00:55:04 INFO - PROCESS | 10593 | Cycle 1(1): loaded http://localhost:44697/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44697/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:55:05 INFO - PROCESS | 10593 | RSS: Main: 148480000 00:55:05 INFO - PROCESS | 10593 | 00:55:07 INFO - PROCESS | 10593 | Cycle 1(1): loaded http://localhost:44697/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44697/tests/kraken/driver.html?testName=ai-astar) 00:55:07 INFO - PROCESS | 10593 | RSS: Main: 148004864 00:55:07 INFO - PROCESS | 10593 | 00:55:07 INFO - PROCESS | 10593 | __start_tp_report 00:55:07 INFO - PROCESS | 10593 | _x_x_mozilla_page_load 00:55:07 INFO - PROCESS | 10593 | _x_x_mozilla_page_load_details 00:55:07 INFO - PROCESS | 10593 | |i|pagename|runs| 00:55:07 INFO - PROCESS | 10593 | |0;ai-astar;114;109;114;116;116;126;116;114;115;116 00:55:07 INFO - PROCESS | 10593 | |1;audio-beat-detection;158;133;155;167;130;161;157;134;175;134 00:55:07 INFO - PROCESS | 10593 | |2;audio-dft;163;163;164;164;166;165;164;164;168;162 00:55:07 INFO - PROCESS | 10593 | |3;audio-fft;72;74;76;146;77;72;72;76;155;72 00:55:07 INFO - PROCESS | 10593 | |4;audio-oscillator;99;98;139;96;98;98;135;97;98;131 00:55:07 INFO - PROCESS | 10593 | |5;imaging-gaussian-blur;109;110;109;110;109;109;111;110;109;117 00:55:07 INFO - PROCESS | 10593 | |6;imaging-darkroom;148;149;148;154;149;148;148;149;149;148 00:55:07 INFO - PROCESS | 10593 | |7;imaging-desaturate;96;97;96;96;96;95;96;97;97;96 00:55:07 INFO - PROCESS | 10593 | |8;json-parse-financial;72;71;73;69;74;75;72;77;72;70 00:55:07 INFO - PROCESS | 10593 | |9;json-stringify-tinderbox;67;67;69;68;68;68;67;67;67;66 00:55:07 INFO - PROCESS | 10593 | |10;stanford-crypto-aes;83;86;86;85;95;84;84;84;82;84 00:55:07 INFO - PROCESS | 10593 | |11;stanford-crypto-ccm;120;125;123;135;138;123;131;122;130;132 00:55:07 INFO - PROCESS | 10593 | |12;stanford-crypto-pbkdf2;141;149;149;148;160;138;153;146;152;136 00:55:07 INFO - PROCESS | 10593 | |13;stanford-crypto-sha256-iterative;72;73;72;71;70;71;73;72;69;73 00:55:07 INFO - PROCESS | 10593 | __end_tp_report 00:55:07 INFO - PROCESS | 10593 | __start_cc_report 00:55:07 INFO - PROCESS | 10593 | _x_x_mozilla_cycle_collect,809 00:55:07 INFO - PROCESS | 10593 | __end_cc_report 00:55:07 INFO - PROCESS | 10593 | __startTimestamp1452675307398__endTimestamp 00:55:07 INFO - PROCESS | 10593 | 00:55:07 INFO - PROCESS | 10593 | ------- Summary: start ------- 00:55:07 INFO - PROCESS | 10593 | Number of tests: 14 00:55:07 INFO - PROCESS | 10593 | 00:55:07 INFO - PROCESS | 10593 | [#0] ai-astar Cycles:10 Average:115.60 Median:116.00 stddev:4.22 (3.6%) stddev-sans-first:4.44 00:55:07 INFO - PROCESS | 10593 | Values: 114.0 109.0 114.0 116.0 116.0 126.0 116.0 114.0 115.0 116.0 00:55:07 INFO - PROCESS | 10593 | 00:55:07 INFO - PROCESS | 10593 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:157.50 stddev:16.24 (10.3%) stddev-sans-first:16.99 00:55:07 INFO - PROCESS | 10593 | Values: 158.0 133.0 155.0 167.0 130.0 161.0 157.0 134.0 175.0 134.0 00:55:07 INFO - PROCESS | 10593 | 00:55:07 INFO - PROCESS | 10593 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:1.70 (1.0%) stddev-sans-first:1.74 00:55:07 INFO - PROCESS | 10593 | Values: 163.0 163.0 164.0 164.0 166.0 165.0 164.0 164.0 168.0 162.0 00:55:07 INFO - PROCESS | 10593 | 00:55:07 INFO - PROCESS | 10593 | [#3] audio-fft Cycles:10 Average:89.20 Median:73.00 stddev:32.43 (44.4%) stddev-sans-first:33.80 00:55:07 INFO - PROCESS | 10593 | Values: 72.0 74.0 76.0 146.0 77.0 72.0 72.0 76.0 155.0 72.0 00:55:07 INFO - PROCESS | 10593 | 00:55:07 INFO - PROCESS | 10593 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:98.00 stddev:18.13 (18.5%) stddev-sans-first:18.87 00:55:07 INFO - PROCESS | 10593 | Values: 99.0 98.0 139.0 96.0 98.0 98.0 135.0 97.0 98.0 131.0 00:55:07 INFO - PROCESS | 10593 | 00:55:07 INFO - PROCESS | 10593 | [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.00 stddev:2.45 (2.2%) stddev-sans-first:2.55 00:55:07 INFO - PROCESS | 10593 | Values: 109.0 110.0 109.0 110.0 109.0 109.0 111.0 110.0 109.0 117.0 00:55:07 INFO - PROCESS | 10593 | 00:55:07 INFO - PROCESS | 10593 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:1.83 (1.2%) stddev-sans-first:1.90 00:55:07 INFO - PROCESS | 10593 | Values: 148.0 149.0 148.0 154.0 149.0 148.0 148.0 149.0 149.0 148.0 00:55:07 INFO - PROCESS | 10593 | 00:55:07 INFO - PROCESS | 10593 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 00:55:07 INFO - PROCESS | 10593 | Values: 96.0 97.0 96.0 96.0 96.0 95.0 96.0 97.0 97.0 96.0 00:55:07 INFO - PROCESS | 10593 | 00:55:07 INFO - PROCESS | 10593 | [#8] json-parse-financial Cycles:10 Average:72.50 Median:72.50 stddev:2.37 (3.3%) stddev-sans-first:2.51 00:55:07 INFO - PROCESS | 10593 | Values: 72.0 71.0 73.0 69.0 74.0 75.0 72.0 77.0 72.0 70.0 00:55:07 INFO - PROCESS | 10593 | 00:55:07 INFO - PROCESS | 10593 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.50 stddev:0.84 (1.2%) stddev-sans-first:0.88 00:55:07 INFO - PROCESS | 10593 | Values: 67.0 67.0 69.0 68.0 68.0 68.0 67.0 67.0 67.0 66.0 00:55:07 INFO - PROCESS | 10593 | 00:55:07 INFO - PROCESS | 10593 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:84.50 stddev:3.62 (4.3%) stddev-sans-first:3.75 00:55:07 INFO - PROCESS | 10593 | Values: 83.0 86.0 86.0 85.0 95.0 84.0 84.0 84.0 82.0 84.0 00:55:07 INFO - PROCESS | 10593 | 00:55:07 INFO - PROCESS | 10593 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:130.50 stddev:6.12 (4.7%) stddev-sans-first:5.78 00:55:07 INFO - PROCESS | 10593 | Values: 120.0 125.0 123.0 135.0 138.0 123.0 131.0 122.0 130.0 132.0 00:55:07 INFO - PROCESS | 10593 | 00:55:07 INFO - PROCESS | 10593 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.20 Median:149.00 stddev:7.28 (4.9%) stddev-sans-first:7.37 00:55:07 INFO - PROCESS | 10593 | Values: 141.0 149.0 149.0 148.0 160.0 138.0 153.0 146.0 152.0 136.0 00:55:07 INFO - PROCESS | 10593 | 00:55:07 INFO - PROCESS | 10593 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:72.00 stddev:1.35 (1.9%) stddev-sans-first:1.42 00:55:07 INFO - PROCESS | 10593 | Values: 72.0 73.0 72.0 71.0 70.0 71.0 73.0 72.0 69.0 73.0 00:55:07 INFO - PROCESS | 10593 | -------- Summary: end -------- 00:55:07 INFO - PROCESS | 10593 | 00:55:08 INFO - TEST-INFO | 10593: exit 0 00:55:08 INFO - TEST-OK | kraken | took 62001ms 00:55:08 INFO - TEST-START | v8_7 00:55:08 INFO - operating with platform_type : linux_ 00:55:08 INFO - Initialising browser for v8_7 test... 00:55:08 INFO - TEST-INFO | started process 10877 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplGHWzE/profile http://localhost:44697/getInfo.html) 00:55:12 INFO - PROCESS | 10877 | 00:55:12 INFO - PROCESS | 10877 | (process:10949): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:55:13 INFO - PROCESS | 10877 | __metrics Screen width/height:1600/1200 00:55:13 INFO - PROCESS | 10877 | colorDepth:24 00:55:13 INFO - PROCESS | 10877 | Browser inner width/height: 1024/697 00:55:13 INFO - PROCESS | 10877 | __metrics 00:55:13 INFO - PROCESS | 10877 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 00:55:14 INFO - TEST-INFO | 10877: exit 0 00:55:14 INFO - Browser initialized. 00:55:14 INFO - Running cycle 1/1 for v8_7 test... 00:55:14 INFO - TEST-INFO | started process 10998 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplGHWzE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:55:15 INFO - PROCESS | 10998 | 00:55:15 INFO - PROCESS | 10998 | (process:11053): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:55:26 INFO - PROCESS | 10998 | RSS: Main: 150110208 00:55:26 INFO - PROCESS | 10998 | 00:55:48 INFO - PROCESS | 10998 | Cycle 1(1): loaded http://localhost:44697/tests/v8_7/run.html (next: http://localhost:44697/tests/v8_7/run.html) 00:55:48 INFO - PROCESS | 10998 | RSS: Main: 145346560 00:55:48 INFO - PROCESS | 10998 | 00:55:48 INFO - PROCESS | 10998 | __start_tp_report 00:55:48 INFO - PROCESS | 10998 | _x_x_mozilla_page_load 00:55:48 INFO - PROCESS | 10998 | _x_x_mozilla_page_load_details 00:55:48 INFO - PROCESS | 10998 | |i|pagename|runs| 00:55:48 INFO - PROCESS | 10998 | |0;Richards;166.16816218012627 00:55:48 INFO - PROCESS | 10998 | |1;DeltaBlue;186.42803877703207 00:55:48 INFO - PROCESS | 10998 | |2;Encrypt;279.17364600781684 00:55:48 INFO - PROCESS | 10998 | |3;Decrypt;5256.544502617801 00:55:48 INFO - PROCESS | 10998 | |4;RayTrace;1072.961373390558 00:55:48 INFO - PROCESS | 10998 | |5;Earley;706.7137809187279 00:55:48 INFO - PROCESS | 10998 | |6;Boyer;12382.716049382716 00:55:48 INFO - PROCESS | 10998 | |7;RegExp;43063.82978723404 00:55:48 INFO - PROCESS | 10998 | |8;Splay;601.4319809069212 00:55:48 INFO - PROCESS | 10998 | |9;NavierStokes;4826.923076923077 00:55:48 INFO - PROCESS | 10998 | __end_tp_report 00:55:48 INFO - PROCESS | 10998 | __startTimestamp1452675348801__endTimestamp 00:55:48 INFO - PROCESS | 10998 | 00:55:48 INFO - PROCESS | 10998 | ------- Summary: start ------- 00:55:48 INFO - PROCESS | 10998 | Number of tests: 10 00:55:48 INFO - PROCESS | 10998 | 00:55:48 INFO - PROCESS | 10998 | [#0] Richards Cycles:1 Average:166.17 Median:166.17 stddev:0.00 (0.0%) 00:55:48 INFO - PROCESS | 10998 | Values: 166.2 00:55:48 INFO - PROCESS | 10998 | 00:55:48 INFO - PROCESS | 10998 | [#1] DeltaBlue Cycles:1 Average:186.43 Median:186.43 stddev:0.00 (0.0%) 00:55:48 INFO - PROCESS | 10998 | Values: 186.4 00:55:48 INFO - PROCESS | 10998 | 00:55:48 INFO - PROCESS | 10998 | [#2] Encrypt Cycles:1 Average:279.17 Median:279.17 stddev:0.00 (0.0%) 00:55:48 INFO - PROCESS | 10998 | Values: 279.2 00:55:48 INFO - PROCESS | 10998 | 00:55:48 INFO - PROCESS | 10998 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 00:55:48 INFO - PROCESS | 10998 | Values: 5256.5 00:55:48 INFO - PROCESS | 10998 | 00:55:48 INFO - PROCESS | 10998 | [#4] RayTrace Cycles:1 Average:1072.96 Median:1072.96 stddev:0.00 (0.0%) 00:55:48 INFO - PROCESS | 10998 | Values: 1073.0 00:55:48 INFO - PROCESS | 10998 | 00:55:48 INFO - PROCESS | 10998 | [#5] Earley Cycles:1 Average:706.71 Median:706.71 stddev:0.00 (0.0%) 00:55:48 INFO - PROCESS | 10998 | Values: 706.7 00:55:48 INFO - PROCESS | 10998 | 00:55:48 INFO - PROCESS | 10998 | [#6] Boyer Cycles:1 Average:12382.72 Median:12382.72 stddev:0.00 (0.0%) 00:55:48 INFO - PROCESS | 10998 | Values: 12382.7 00:55:48 INFO - PROCESS | 10998 | 00:55:48 INFO - PROCESS | 10998 | [#7] RegExp Cycles:1 Average:43063.83 Median:43063.83 stddev:0.00 (0.0%) 00:55:48 INFO - PROCESS | 10998 | Values: 43063.8 00:55:48 INFO - PROCESS | 10998 | 00:55:48 INFO - PROCESS | 10998 | [#8] Splay Cycles:1 Average:601.43 Median:601.43 stddev:0.00 (0.0%) 00:55:48 INFO - PROCESS | 10998 | Values: 601.4 00:55:48 INFO - PROCESS | 10998 | 00:55:48 INFO - PROCESS | 10998 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 00:55:48 INFO - PROCESS | 10998 | Values: 4826.9 00:55:48 INFO - PROCESS | 10998 | -------- Summary: end -------- 00:55:48 INFO - PROCESS | 10998 | 00:55:49 INFO - TEST-INFO | 10998: exit 0 00:55:49 INFO - TEST-OK | v8_7 | took 41314ms 00:55:49 INFO - SUITE-END | took 1217s 00:55:49 INFO - Completed test suite (00:20:17) 00:55:49 INFO - Working with test: dromaeo_css 00:55:49 INFO - Generating results file: dromaeo_css 00:55:49 INFO - Working with test: kraken 00:55:49 INFO - Generating results file: kraken 00:55:49 INFO - javascript benchmark 00:55:49 INFO - Working with test: v8_7 00:55:49 INFO - Generating results file: v8_7 00:55:49 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:55:49 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 00:55:49 INFO - process_Request line: dromaeo_css 6231.33 graph.html#tests=[[72,132,43]] 00:55:49 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:55:50 INFO - process_Request line: kraken 1555.80 graph.html#tests=[[232,132,43]] 00:55:50 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:55:50 INFO - process_Request line: v8_7 20298.66 graph.html#tests=[[230,132,43]] 00:55:50 INFO - RETURN: dromaeo_css: 6231.33 00:55:50 INFO - RETURN: kraken: 1555.80 00:55:50 INFO - RETURN: v8_7: 20298.66 00:55:50 INFO - javascript benchmark 00:55:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2606.374470127169, 2619.567771317733, 2650.2446802661248, 2661.2415461593437, 2664.5203863304605, 4373.147236288925, 4468.776561171941, 4471.463424389078, 4485.0, 4543.409356783622, 4398.362237475572, 4513.2101882170655, 4589.518100599439, 4620.607248383883, 4684.672072954894, 4048.777317247565, 4258.190943720683, 4279.33670281107, 4316.762578058206, 4370.584794444539, 4121.5878412158845, 4323.265044942367, 4339.956600434002, 4350.847720329789, 4360.847370342039, 4123.051698109437, 4177.895552611179, 4243.639290660267, 4243.830246790125, 4262.616364527207, 4182.1008483176265, 4187.706860519765, 4201.747895126302, 4215.45199124115, 4232.32282834748, 4165.958340416587, 4171.20747058058, 4176.812043458051, 4199.790010499462, 4227.682923780698, 4463.397441345442, 4536.251518499444, 4536.34223037661, 4544.113897789933, 4560.110778398213, 4769.928451073237, 4784.928226076611, 4794.832180873687, 4828.179209534387, 4838.153323168432, 4750.596199323062, 4845.636577256684, 4854.6359023073055, 4926.187179115442, 4985.152524070917, 4495.550444955478, 4509.706869053501, 4517.9774101129615, 4528.343390208402, 4569.0, 4980.427250866124, 4991.975040124777, 5005.649604527648, 5006.173981293119, 5062.544371006627, 4664.137134630037, 4806.975965120222, 4807.230843065093, 4808.06242782654, 4869.732164730974, 4816.060868130681, 4823.469418363977, 4855.781489832966, 4865.6107511399005, 4905.656604037755, 4830.347903033045, 4839.467658557556, 4854.2233242681, 4865.343178670905, 4903.485134060944, 4643.326717625925, 4689.226277664216, 4767.284907263869, 4825.831095911696, 4879.780409881564, 3965.0285680008583, 3966.0283230608684, 3966.3058964681063, 4007.1184339445276, 4028.798560071985, 3551.271989242199, 3566.411542095525, 3573.6426357364057, 3585.5338805955057, 3598.2803439312243, 4173.457450531411, 4244.702870799076, 4247.065645557972, 4282.678799090018, 4286.935695964563, 4823.975880120647, 4900.26496025599, 4915.36100306965, 4915.729634870117, 4960.950390496048, 4142.0, 4165.541790403053, 4167.791610419466, 4169.728967617095, 4195.223883581547, 4202.201581699467, 4241.257779888507, 4247.256730072225, 4255.8084886180195, 4319.762413067248, 4593.0, 4601.44782626087, 4635.0498147878925, 4661.091087237956, 4685.718856868599, 4889.462159162418, 4900.362952816111, 4921.237208232729, 4921.753912304299, 4928.0, 4482.820687172477, 4571.451425828922, 4596.402467679314, 4680.344751734692, 4690.413698287714, 4796.592289655418, 4816.373871396696, 4825.565699087099, 4838.661293709407, 4845.830395936126, 4862.294967229661, 4862.41651001882, 4887.120318342732, 4899.216125420058, 4936.7284799336385, 4604.608608268335, 4682.063587282625, 4718.480967093548, 4737.431508219036, 4829.541193586604, 4759.2147295697205, 4761.523847615211, 4772.6181905448175, 4785.784639691153, 4811.975940120417, 4662.0442809224705, 4662.184117779308, 4667.066586682609, 4676.158291507561, 4717.386739723814, 4590.839320623762, 4654.418197725285, 4656.068786242833, 4708.105459962596, 4795.088933102699, 4692.812287508462, 4694.06118776253, 4694.108119457293, 4701.764911754331, 4754.168020596313], "unit": "score", "name": "dojo.html", "value": 4468.240929148195}, {"lowerIsBetter": false, "replicates": [481.72541651258774, 520.8775937654652, 542.3329304954906, 545.6344249352933, 548.8819903720699, 34925.82537087314, 35650.0, 35657.64342356576, 35660.64339356605, 35795.64204357956, 40626.59373406265, 40986.18027639445, 41081.17837643253, 41142.382864256986, 41252.38121428173, 7742.109657389387, 7801.531908085504, 7894.881576776353, 7901.881471777928, 7904.683812647487, 7700.229977002311, 7787.88318175225, 7874.606269686521, 7891.21087891212, 7892.013498312711, 7834.647440865147, 7917.722879699211, 7926.722564710236, 7947.841043179133, 7951.045874495068, 7807.063152421717, 7813.687452501865, 7863.410244231648, 7879.0, 7901.525908445512, 7730.033745781778, 7873.267881066156, 7876.17300183484, 7886.605669716491, 7900.723474678416, 36836.0790980225, 37439.25121497582, 37485.81257093697, 37550.624493754985, 37573.81213093917, 2601.5447296722996, 2692.3269182704325, 2712.6744790625053, 2734.6581677290337, 3146.7639927005566, 27974.580381294298, 28139.577906331422, 28471.145865623857, 28659.42681146386, 28785.856070719514, 3342.8495717692763, 3389.8983030509125, 3480.4083305838067, 3505.719542436599, 3536.504889315498, 212613.0, 213997.99999999846, 214224.0, 214624.0, 215443.0, 37455.62544374576, 51958.74020629948, 52288.21567676488, 52367.476325237025, 52402.47597524052, 36523.0, 36630.63369366326, 36748.0, 36832.0, 36842.0, 12304.323262220663, 12327.137100403064, 12365.629031129081, 12473.812892806614, 12477.376131193403, 9190.035046320174, 9256.213221876082, 9265.675701350556, 9276.16514513697, 9278.072192780668, 12867.42096605655, 12938.288394138224, 13144.934275328562, 13266.602001939764, 13287.601371958857, 5327.493888080626, 5450.345958485007, 5507.834764957058, 5534.695591742493, 5539.0, 825.7770401991429, 836.4061516323478, 860.6299291304799, 948.3124734567383, 992.3053862296422, 24991.5001699965, 25379.74620253774, 25455.236342909742, 25502.74497255041, 25554.10560630369, 892.1970226795806, 957.5020989085637, 983.179045497018, 992.3549692699659, 1068.0654427376046, 14700.0, 15025.624359391102, 15199.088054716753, 15325.846741532665, 15594.220288985733, 245798.0, 247906.0, 248738.0, 248972.0, 249607.0, 48208.0, 49283.75358123187, 49671.0, 49747.0, 49912.50087499079, 1164.574930150506, 1171.191877604433, 1172.554429316854, 1208.3414539076225, 1220.9023278137906, 27008.59487107734, 27164.0, 27271.590926135726, 27433.725662743116, 27619.51424371816, 38756.6124338753, 39260.214795704494, 39293.607063929, 39325.80337098296, 39383.21233575255, 243051.0, 245670.0, 245696.0, 245978.0, 246537.0, 28486.857565712868, 29250.414991700472, 39333.21333573255, 40040.799796002, 40137.1972560553, 34675.65324346724, 35106.64893351034, 35562.82218588994, 35738.0, 35751.64248357483, 32532.34935301328, 32803.67196328102, 32992.0, 33970.15074623154, 33970.49044264387, 32833.179170520925, 33363.0, 33913.66086339204, 35375.0, 36116.45825312675, 30233.69766302397, 30846.0, 32916.0, 32973.50539741858, 33216.501752474214, 28929.42141157207, 29931.251718706335, 30510.590902961223, 30831.2292192688, 33943.0, 23778.881105595054, 24014.0, 24119.276421707378, 24283.757162428148, 24841.0], "unit": "score", "name": "ext.html", "value": 16176.04548607694}, {"lowerIsBetter": false, "replicates": [350.8491348720051, 351.16598079561044, 352.37981153170426, 352.494170864809, 353.58630402429156, 14449.927750361247, 14799.0, 14826.258687065658, 15567.455139070134, 16257.430989915341, 9431.905680943206, 9691.273154513405, 10961.397123158224, 13931.0, 14168.858311416883, 4150.128473020662, 4307.633851122659, 4321.6326612238, 4327.653787696977, 4802.471728109905, 4903.901921961558, 4934.80260789568, 4936.605071594264, 4938.234573641092, 4944.802207911679, 5120.974395128019, 5676.97814393409, 5714.171445140452, 5908.793192238272, 5951.375105613914, 6015.308239552463, 6024.427679370453, 6033.577649564532, 6636.004599310094, 6670.833229169261, 5804.2744656917885, 6346.397092276273, 6372.044193370985, 6385.201849768779, 6388.361163883621, 19186.424407267805, 19487.317943871898, 19624.901875490676, 20353.185872565078, 20765.442591805677, 1824.7354133650679, 1831.2766457249445, 1898.515878451, 1900.9904950475159, 1941.175000624743, 12850.485980560767, 12907.096503244777, 13061.673458163621, 13397.995150363762, 13399.409510773208, 1832.9175187116612, 1839.0804597701149, 1847.6581832361055, 1866.1602278974515, 1925.9133338999638, 56444.71777641086, 57233.14150287749, 57407.0, 58112.0, 58598.7070064647, 14562.85437145615, 14628.853711462962, 14695.191764452844, 14779.0, 14986.70026599462, 21689.0, 21809.709980452142, 21863.12547498114, 22101.778982209973, 22190.445238869157, 8262.462939908886, 8298.045724741733, 8313.210245026712, 8317.584120793936, 8341.624626891804, 6828.2488926218075, 6882.03651488792, 6899.0, 6942.826429339307, 6963.617001064888, 7214.96392518034, 7319.451041171933, 7344.853102937911, 7368.410527157815, 7405.555666660018, 1711.6662250861211, 1772.4151030160274, 2929.765618750495, 2963.777716671258, 3052.0, 781.984360312802, 805.9153788852203, 848.804774901776, 876.4741155306765, 929.5166513412987, 14265.500707475188, 14572.344244509022, 14677.853221467649, 15067.623309417353, 15135.924320378328, 818.9877151842727, 842.4439869685978, 848.6393282854762, 862.779991102265, 929.3958926697701, 8557.27263182624, 8567.74296771098, 8835.911640883509, 9034.548272586344, 9479.857802132974, 473894.0, 475133.0, 499006.0, 500547.0, 505644.0, 63334.68332658307, 63561.68219158967, 63805.68097159485, 64093.67953160204, 64286.67856660687, 1033.1476531861244, 1085.8968398002178, 1086.4567716141771, 1094.0591091661324, 1104.972375690598, 13490.52783152585, 13684.452621895012, 13812.86187138156, 13961.232132232824, 14152.929235353757, 30465.23836904095, 30661.693383065885, 30848.0, 31015.53476697806, 31108.222294441915, 42705.57294427016, 43486.34770478508, 43765.56234437615, 44963.55036449724, 44978.77510612426, 6361.363863613602, 6491.221053473613, 6594.604323740591, 6602.7689030883685, 6808.319168083152, 7221.0, 9781.559829807818, 10029.197664186993, 10076.899231007596, 10310.845337319795, 8224.276743329585, 8321.916780832356, 8405.285550728257, 8414.4109912308, 8520.659173632985, 9149.405288656217, 9322.0, 9428.858567121362, 9503.904960950578, 9720.854187187339, 8201.384896132933, 8486.363522735695, 8585.527795971282, 8771.91228087711, 8817.955910220664, 6912.792616221522, 7028.789136325919, 7041.647917604202, 7176.461765367722, 7221.169565500035, 7249.746258880914, 8889.599968001585, 8934.776630584287, 8956.955215223883, 8966.730998070068], "unit": "score", "name": "jquery.html", "value": 8212.52537930497}, {"lowerIsBetter": false, "replicates": [1311.3705421397729, 1381.903266771326, 1454.934527946243, 1726.689195944731, 1757.9912100439487, 6997.545159564625, 7130.286971302874, 7273.381762550176, 7328.157261914881, 7336.706531738724, 7326.230745771697, 7339.0, 7419.07261592301, 7430.851382972337, 7432.145303290124, 2146.474113842107, 2177.1073859717517, 2178.117862265785, 2183.1376606240524, 2191.276878630056, 2217.5010622609943, 2218.5784700906775, 2261.050358849287, 2261.3555136786017, 2265.5355652091366, 1754.456118603237, 1796.0391190712971, 2139.358192542239, 2177.4991751897073, 2207.2716003718815, 2155.245664017597, 2170.9891450542727, 2181.345596321113, 2184.432047667602, 2186.5517568898335, 2073.782252863443, 2149.2370208575885, 2160.8703477791228, 2170.25126331417, 2179.9564008719735, 7200.495965282433, 7221.638918054076, 7230.349268565854, 7239.131304243525, 7240.746573869889, 4157.750534967881, 4266.0827921996915, 4267.253230684649, 4270.167317373113, 4282.528921818597, 2750.9037183698474, 2773.514634938898, 2781.1378472673537, 2789.5536714125847, 2792.2042217967983, 801.5791709352578, 839.1524560194248, 841.7348535211389, 896.0770406481334, 910.6084383715, 9622.518874056339, 9840.852387214127, 9843.064908833649, 9843.803123937481, 9845.064718851769, 3862.304785138702, 3961.2869683457257, 4016.2971479990883, 4088.693347998912, 4137.358709400048, 8602.741917742478, 8615.267702245379, 8642.524661143698, 8663.91336086631, 8673.392862499564, 4322.330038843984, 4334.523202447728, 4364.3017117261725, 4374.19077470669, 4379.343098535245, 3895.162540053902, 3900.7074469414906, 3927.0575061985487, 3935.6064393560987, 3950.20995800841, 3266.2324353776844, 3447.5518182636597, 3461.8615255390005, 3463.0130412832223, 3471.0628130405153, 1039.6465201831263, 1080.0657431322006, 1080.1358912869673, 1088.031651829872, 1090.7763908398758, 788.8974433323746, 801.2308184143171, 833.9332853371716, 915.4827522449795, 917.27535247154, 6364.6181229126405, 6513.609183449008, 6529.0, 6530.2816690164045, 6558.737650494022, 538.5530010091614, 552.2268823646846, 558.5643198305328, 560.2380762163455, 697.2713514377488, 5033.2701758245585, 5086.72023038729, 5088.643794934319, 5097.541221290102, 5100.821471248562, 8307.335413166933, 8550.914490855137, 8612.440191387539, 8680.131986801396, 8703.521306328214, 8568.657253709907, 8574.356923230782, 8590.355723320776, 8602.440841345293, 8616.870746938801, 6782.660866956632, 6860.382565569123, 6861.828454288683, 6923.376896079377, 6955.478339124586, 6837.1111755471475, 6931.09895713554, 6934.895976560457, 6938.202106757787, 6980.092587963532, 7834.334081603128, 8180.304674102768, 8201.343892488467, 8217.096119426978, 8400.705975290835, 8247.463914845515, 8461.23848853606, 8524.659013639384, 8546.316294696533, 8595.65617375298, 6232.8130156095385, 6235.282942461675, 6302.873942521215, 6311.621302721851, 6337.176167098248, 6545.2800191979795, 6627.867442651216, 6636.634985075867, 6643.236027856665, 6644.169478815148, 6323.841903952438, 6328.746850125944, 6369.617822930639, 6427.710753016219, 6569.9014514783275, 5504.504594586507, 5923.614965027259, 6232.626042437469, 6311.526635502448, 6381.489480841615, 6022.879542409215, 6172.660503672341, 6313.273973493107, 6374.872502549831, 6406.679666016774, 6053.667048312385, 6074.90887636677, 6092.512598991982, 6103.786367477117, 6112.0, 5967.075103358986, 5980.700964951648, 5995.760169593342, 6003.249593800775, 6013.639181649115], "unit": "score", "name": "mootools.html", "value": 4066.984574430738}, {"lowerIsBetter": false, "replicates": [294.78186142254725, 298.51342312031386, 298.84460080758004, 298.99402011959774, 302.67764830455565, 5556.999740046795, 5579.4699503547145, 5638.295213098363, 5654.293213348336, 5678.43215678432, 5537.778488860441, 5539.612227144102, 5551.1673249012665, 5554.305711786027, 5555.166724991253, 4047.7166598338126, 4243.236217480852, 4249.957500425003, 4250.234957707604, 4257.318828987362, 4136.937945930814, 4137.027798467358, 4257.787110644471, 4257.914841703164, 4261.4673165854265, 4185.455890734215, 4196.538380778112, 4204.474440694913, 4214.157168566284, 4221.936670949938, 4203.0543127796, 4208.148414697524, 4208.537060923296, 4212.389203565466, 4213.6839737019845, 3688.207035487383, 3691.3909204981146, 3691.8338674759702, 3695.9076023099637, 3698.8705395311304, 5210.348706411699, 5350.839474815762, 5363.088274993261, 5365.812196573102, 5390.4879036491475, 4847.733374664392, 4862.610991120702, 4869.318295438641, 4872.123017856784, 4876.829310974134, 5779.422057794229, 5785.768569257225, 5791.768329266824, 5794.275715535558, 5797.797077102281, 4025.677945764332, 4029.37544680575, 4030.5969403059753, 4034.4755181826467, 4036.091879327128, 5981.461668449817, 6111.236095488064, 6123.663198524079, 6125.479334256594, 6136.907946380852, 4150.709450338447, 4151.12826306473, 4156.314208155621, 4156.896077598084, 4160.292750232467, 4184.330507118846, 4215.852445164404, 4224.894377640522, 4226.387173859773, 4226.5773422657485, 4829.806807727722, 4830.0, 4832.879178020507, 4836.758162091881, 4844.4186697596515, 5688.715564221772, 5754.769809207669, 5780.046292361797, 5795.913061304083, 5802.651840889475, 1443.826740791112, 1496.4388354367113, 1500.6248437890526, 1500.6998600279987, 1501.3544176004423, 1009.9849651100596, 1022.325265324882, 1041.880183778875, 1045.6235755128148, 1057.984130238047, 5065.544101030851, 5086.847394578169, 5100.6429549931145, 5101.821436249714, 5105.2342148678, 5981.491573216238, 6040.184575082308, 6042.093685947055, 6130.141780150782, 6140.263168419819, 5111.616628752859, 5130.948690513047, 5148.819791307361, 5158.690478571298, 5164.767585458663, 3257.006612983063, 3270.5094235864813, 3278.262390962062, 3279.2785587170783, 3291.374638818617, 5630.4369563043365, 5736.77052917887, 5738.942610573924, 5754.6547207167705, 5757.193992841006, 6227.532935029891, 6257.78097766576, 6279.905801412982, 6286.0, 6292.465140463112, 5712.400197979152, 5741.282339707536, 5743.712814359265, 5748.971255143698, 5767.250257466587, 6067.787627433196, 6069.848253793514, 6097.634141951497, 6104.633721976696, 6108.11432342299, 5694.686792226467, 5864.06175011996, 5938.287405511366, 5946.226990491208, 5955.40445955401, 5660.4905558498285, 5703.686297253691, 5716.456936591017, 5752.539796816328, 5772.913406298825, 4005.9399109012807, 4008.398740188995, 4024.5170579530645, 4027.154297597537, 4044.8179831908224, 5948.553858460719, 6062.818115456544, 6102.389761023862, 6103.7253323601435, 6119.388061193845, 5864.914990726729, 5865.237519122486, 5867.0, 5869.73586188614, 5878.412158784087, 5835.591508594527, 5865.0, 5876.588638795243, 5878.441548052928, 5879.118132280021, 5633.464820842013, 5722.484976352148, 5754.56840736938, 5756.769729210785, 5758.856028599151, 5896.321922978912, 5909.91135132982, 5926.822195334147, 5928.8814223716145, 5933.673647949232, 5766.711664416678, 5770.076787713946, 5779.450952159538, 5808.709564521672, 5811.4479124483105], "unit": "score", "name": "prototype.html", "value": 4364.403363704228}, {"lowerIsBetter": false, "replicates": [761.7181642792167, 771.1928579968915, 775.0428221146883, 778.6729573579096, 821.6179476543408, 11370.09039276858, 11457.427128643576, 11566.53733850646, 11613.303201807887, 11640.18518703689, 10044.99550044997, 11068.667939961813, 11393.145514086435, 11412.42937853106, 11469.31184128953, 758.7306506190306, 775.8370742144128, 776.4719990406521, 776.5690042026673, 779.9727009554666, 783.7335305995961, 783.9137694853562, 786.7325109462781, 786.799366161628, 790.2690011739147, 818.6561644109488, 820.0651257566379, 821.1378053044309, 821.1542111625006, 823.1192623892438, 810.3031393002013, 812.9268365847103, 813.0203105258149, 813.6257321632027, 817.2440492544432, 606.8998615228483, 607.6931149769382, 608.5831205624118, 610.4018062298971, 610.4414460768392, 10606.257561970666, 10612.575496980111, 10626.415547144903, 10647.57409703611, 10685.519151638195, 9679.612815487371, 9777.706668799876, 9842.360246583949, 9848.556814943344, 10261.333013354108, 7846.646900889474, 8065.072516660601, 8617.61220745068, 8649.783755406103, 8696.0, 3094.5358196270513, 3128.4212420702243, 3159.08386567895, 3166.730827879633, 3199.3441344524317, 37506.62493375059, 37578.62421375779, 38126.42482902042, 38148.0, 38371.0, 9019.143181397756, 9025.458472491671, 9072.183503484717, 9092.81814363709, 9336.859947100664, 14686.87040379139, 15053.548393548212, 15058.171800551076, 15093.773593396108, 15104.622384440258, 6431.517636177212, 6458.806235812933, 6460.806175814733, 6477.287498375175, 6494.4479719223455, 3464.255185135208, 3491.5810102787827, 3513.543239378864, 3565.5186549815962, 3619.261630855214, 2699.298182472571, 2722.7957903157344, 2725.441284536665, 2728.331558768075, 2730.1536523677723, 487.9487653796371, 489.6768133032182, 492.97781599828096, 498.5811917988834, 499.9325091112726, 452.3508764922347, 494.9331840201599, 499.8850264439199, 567.1690972724978, 605.5065121925617, 7611.581363024976, 7725.343345815556, 7850.803729906798, 7966.243206895336, 7987.920120798718, 438.28121880116, 567.7501899164355, 612.0024360292695, 617.4072890025536, 619.4796371048341, 3547.9290414191573, 3692.7599706019023, 3725.5343082114737, 3773.64150405711, 3793.260314238697, 44095.33856992148, 46742.532574673816, 47320.0, 47342.76328618335, 47451.762741186074, 40703.79648101741, 41848.0, 45347.09305813865, 47933.28100078501, 48258.0, 32256.35487290241, 33782.15544611404, 40613.79693101575, 42910.7854460732, 43152.568474315485, 7620.314171724572, 7784.026996625422, 8031.55826429552, 8184.0, 8262.462939908886, 27399.0, 27781.722182777914, 27944.44111117807, 28422.0, 28468.0, 37117.81441092777, 37247.25505489821, 37292.0, 37317.25365492621, 37820.810895945346, 9698.70903872885, 9734.561944712646, 10322.690319290434, 10356.119729822749, 10776.191785615953, 11236.269642473213, 11281.887181128412, 11299.209055366375, 11356.772864542498, 11365.033972112464, 10566.841497377392, 10664.306820056672, 10696.304740191863, 10955.61655342091, 11183.888161118284, 9324.974252832048, 9660.516974151124, 10168.186545076229, 10794.0, 11043.061339786209, 8906.510141942255, 9673.613055477703, 10001.249906256915, 10452.947735261276, 10562.207834412604, 8889.155530224618, 9088.818223635622, 9178.954105229432, 9217.170454659114, 9443.150116489274, 8568.271696905584, 8654.956725216334, 8720.21518063352, 8804.955975220339, 9049.819003620023], "unit": "score", "name": "yui.html", "value": 5555.984392878737}], "name": "dromaeo_css", "value": 6231.336659656611}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 109.0, 114.0, 116.0, 116.0, 126.0, 116.0, 114.0, 115.0, 116.0], "unit": "score", "name": "ai-astar", "value": 115.6}, {"lowerIsBetter": true, "replicates": [158.0, 133.0, 155.0, 167.0, 130.0, 161.0, 157.0, 134.0, 175.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 150.4}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 164.0, 164.0, 166.0, 165.0, 164.0, 164.0, 168.0, 162.0], "unit": "score", "name": "audio-dft", "value": 164.3}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 76.0, 146.0, 77.0, 72.0, 72.0, 76.0, 155.0, 72.0], "unit": "score", "name": "audio-fft", "value": 89.2}, {"lowerIsBetter": true, "replicates": [99.0, 98.0, 139.0, 96.0, 98.0, 98.0, 135.0, 97.0, 98.0, 131.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 111.0, 110.0, 109.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.3}, {"lowerIsBetter": true, "replicates": [148.0, 149.0, 148.0, 154.0, 149.0, 148.0, 148.0, 149.0, 149.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 149.0}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 95.0, 96.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 73.0, 69.0, 74.0, 75.0, 72.0, 77.0, 72.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 72.5}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 69.0, 68.0, 68.0, 68.0, 67.0, 67.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.4}, {"lowerIsBetter": true, "replicates": [83.0, 86.0, 86.0, 85.0, 95.0, 84.0, 84.0, 84.0, 82.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [120.0, 125.0, 123.0, 135.0, 138.0, 123.0, 131.0, 122.0, 130.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.9}, {"lowerIsBetter": true, "replicates": [141.0, 149.0, 149.0, 148.0, 160.0, 138.0, 153.0, 146.0, 152.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.2}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 72.0, 71.0, 70.0, 71.0, 73.0, 72.0, 69.0, 73.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.6}], "name": "kraken", "value": 1555.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.16816218012627], "unit": "score", "name": "Richards", "value": 212.4474360000001}, {"lowerIsBetter": false, "replicates": [186.42803877703207], "unit": "score", "name": "DeltaBlue", "value": 354.6569519999998}, {"lowerIsBetter": false, "replicates": [279.17364600781684], "unit": "score", "name": "Encrypt", "value": 953.4603419999996}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [1072.961373390558], "unit": "score", "name": "RayTrace", "value": 689.6697479999999}, {"lowerIsBetter": false, "replicates": [706.7137809187279], "unit": "score", "name": "Earley", "value": 943.0451449999999}, {"lowerIsBetter": false, "replicates": [12382.716049382716], "unit": "score", "name": "Boyer", "value": 53.822036889332054}, {"lowerIsBetter": false, "replicates": [43063.82978723404], "unit": "score", "name": "RegExp", "value": 21.154295948616586}, {"lowerIsBetter": false, "replicates": [601.4319809069212], "unit": "score", "name": "Splay", "value": 135.49495634920638}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20298.660325398047}]} 00:55:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20298.66"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1555.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6231.33"}}} 00:55:50 INFO - Return code: 0 00:55:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:55:50 INFO - # TBPL SUCCESS # 00:55:50 INFO - Running post-action listener: _resource_record_post_action 00:55:50 INFO - Running post-run listener: _resource_record_post_run 00:55:51 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 0; Write bytes: 539553792; Read time: 0; Write time: 485732 00:55:51 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 231116800; Read time: 0; Write time: 243092 00:55:51 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 308436992; Read time: 0; Write time: 242640 00:55:51 INFO - Running post-run listener: _upload_blobber_files 00:55:51 INFO - Blob upload gear active. 00:55:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:55:51 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 00:55:51 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'] 00:55:51 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 00:55:51 INFO - (blobuploader) - INFO - Open directory for files ... 00:55:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:55:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:55:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:55:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:55:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:55:52 INFO - (blobuploader) - INFO - Done attempting. 00:55:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:55:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:55:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:55:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:55:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:55:53 INFO - (blobuploader) - INFO - Done attempting. 00:55:53 INFO - (blobuploader) - INFO - Iteration through files over. 00:55:53 INFO - Return code: 0 00:55:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:55:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:55:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e27eae204b9c87e898cd00bfc7fa17522069dc0c13ca2930dae69a5fd42bcb4b796c737b6f3fee3e5946836ef8c45c203d350a95537a940eff5e5142b446610a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9bc2bb1c7b96a40e3584593074fad1c51c078adcd9deca15eb6af7ad66b65c686156109989ca91fe800592c03ac8ac3d7605de89d9add4f9dbb8fc3d728648a7"} 00:55:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:55:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:55:53 INFO - Contents: 00:55:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e27eae204b9c87e898cd00bfc7fa17522069dc0c13ca2930dae69a5fd42bcb4b796c737b6f3fee3e5946836ef8c45c203d350a95537a940eff5e5142b446610a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9bc2bb1c7b96a40e3584593074fad1c51c078adcd9deca15eb6af7ad66b65c686156109989ca91fe800592c03ac8ac3d7605de89d9add4f9dbb8fc3d728648a7"} 00:55:53 INFO - Copying logs to upload dir... 00:55:53 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1282.743879 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-01-13 00:55:52.845691) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 00:55:52.849116) ========= 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=920470bf432669ad7e3a5387000001ca-1452668763.40087-751281491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e27eae204b9c87e898cd00bfc7fa17522069dc0c13ca2930dae69a5fd42bcb4b796c737b6f3fee3e5946836ef8c45c203d350a95537a940eff5e5142b446610a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9bc2bb1c7b96a40e3584593074fad1c51c078adcd9deca15eb6af7ad66b65c686156109989ca91fe800592c03ac8ac3d7605de89d9add4f9dbb8fc3d728648a7"} build_url:https://queue.taskcluster.net/v1/task/apvA7PSFTCWjUAtS8fuDTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011261 build_url: 'https://queue.taskcluster.net/v1/task/apvA7PSFTCWjUAtS8fuDTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e27eae204b9c87e898cd00bfc7fa17522069dc0c13ca2930dae69a5fd42bcb4b796c737b6f3fee3e5946836ef8c45c203d350a95537a940eff5e5142b446610a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9bc2bb1c7b96a40e3584593074fad1c51c078adcd9deca15eb6af7ad66b65c686156109989ca91fe800592c03ac8ac3d7605de89d9add4f9dbb8fc3d728648a7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 00:55:52.874374) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 00:55:52.874709) ========= 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=920470bf432669ad7e3a5387000001ca-1452668763.40087-751281491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 00:55:52.957433) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 00:55:52.957757) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 00:55:52.958067) ========= ========= Total master_lag: 0.24 =========